builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-016 starttime: 1454652735.96 results: success (0) buildid: 20160204193034 builduid: 690138059bcc4e3ab0c9da97a7234e35 revision: 5e024441510f6d2b460e570d0e6d2dee0dc89723 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-04 22:12:15.961206) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-04 22:12:15.961685) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-04 22:12:15.961972) ========= 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=00204705a9daa57ed339a427000001b9-1454652072.156634-1829845297 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006261 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-04 22:12:15.984836) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-04 22:12:15.985145) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-04 22:12:16.005992) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 22:12:16.006400) ========= 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=00204705a9daa57ed339a427000001b9-1454652072.156634-1829845297 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021148 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 22:12:16.055684) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-04 22:12:16.056085) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-04 22:12:16.056592) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 22:12:16.056864) ========= 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=00204705a9daa57ed339a427000001b9-1454652072.156634-1829845297 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-04 22:12:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.7M=0s 2016-02-04 22:12:16 (42.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.153492 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 22:12:16.225084) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 22:12:16.225536) ========= 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=00204705a9daa57ed339a427000001b9-1454652072.156634-1829845297 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.042882 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 22:12:16.280229) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 22:12:16.280633) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5e024441510f6d2b460e570d0e6d2dee0dc89723 --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 5e024441510f6d2b460e570d0e6d2dee0dc89723 --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=00204705a9daa57ed339a427000001b9-1454652072.156634-1829845297 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-04 22:12:16,287 truncating revision to first 12 chars 2016-02-04 22:12:16,287 Setting DEBUG logging. 2016-02-04 22:12:16,287 attempt 1/10 2016-02-04 22:12:16,287 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5e024441510f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-04 22:12:16,606 unpacking tar archive at: mozilla-central-5e024441510f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.571756 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 22:12:16.864988) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-04 22:12:16.865334) ========= echo 5e024441510f6d2b460e570d0e6d2dee0dc89723 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'5e024441510f6d2b460e570d0e6d2dee0dc89723'] 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=00204705a9daa57ed339a427000001b9-1454652072.156634-1829845297 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 5e024441510f6d2b460e570d0e6d2dee0dc89723 program finished with exit code 0 elapsedTime=0.004164 script_repo_revision: '5e024441510f6d2b460e570d0e6d2dee0dc89723' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-04 22:12:16.917895) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-04 22:12:16.918201) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-04 22:12:16.932847) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-02-04 22:12:16.933184) ========= /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=00204705a9daa57ed339a427000001b9-1454652072.156634-1829845297 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:12:17 INFO - MultiFileLogger online at 20160204 22:12:17 in /builds/slave/test-pgo 22:12:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 22:12:17 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:12:17 INFO - {'append_to_log': False, 22:12:17 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:12:17 INFO - 'blob_upload_branch': 'Firefox', 22:12:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:12:17 INFO - 'branch': 'Firefox', 22:12:17 INFO - 'buildbot_json_path': 'buildprops.json', 22:12:17 INFO - 'config_files': ('talos/linux_config.py',), 22:12:17 INFO - 'default_actions': ('clobber', 22:12:17 INFO - 'read-buildbot-config', 22:12:17 INFO - 'download-and-extract', 22:12:17 INFO - 'populate-webroot', 22:12:17 INFO - 'create-virtualenv', 22:12:17 INFO - 'install', 22:12:17 INFO - 'run-tests'), 22:12:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:12:17 INFO - 'download_minidump_stackwalk': True, 22:12:17 INFO - 'download_symbols': 'ondemand', 22:12:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:12:17 INFO - 'tooltool.py': '/tools/tooltool.py', 22:12:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:12:17 INFO - '/tools/misc-python/virtualenv.py')}, 22:12:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:12:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:12:17 INFO - 'installer_path': 'installer.exe', 22:12:17 INFO - 'log_level': 'info', 22:12:17 INFO - 'log_name': 'talos', 22:12:17 INFO - 'log_to_console': True, 22:12:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:12:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:12:17 INFO - 'opt_config_files': (), 22:12:17 INFO - 'pip_index': False, 22:12:17 INFO - 'sps_profile': False, 22:12:17 INFO - 'sps_profile_interval': 0, 22:12:17 INFO - 'suite': 'dromaeojs', 22:12:17 INFO - 'system_bits': '32', 22:12:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:12:17 INFO - 'title': 'talos-linux64-ix-016', 22:12:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:12:17 INFO - 'use_talos_json': True, 22:12:17 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:12:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:12:17 INFO - 'work_dir': 'build'} 22:12:17 INFO - ##### 22:12:17 INFO - ##### Running clobber step. 22:12:17 INFO - ##### 22:12:17 INFO - Running pre-action listener: _resource_record_pre_action 22:12:17 INFO - Running main action method: clobber 22:12:17 INFO - rmtree: /builds/slave/test-pgo/build 22:12:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:12:18 INFO - Running post-action listener: _resource_record_post_action 22:12:18 INFO - ##### 22:12:18 INFO - ##### Running read-buildbot-config step. 22:12:18 INFO - ##### 22:12:18 INFO - Running pre-action listener: _resource_record_pre_action 22:12:18 INFO - Running main action method: read_buildbot_config 22:12:18 INFO - Using buildbot properties: 22:12:18 INFO - { 22:12:18 INFO - "project": "", 22:12:18 INFO - "product": "firefox", 22:12:18 INFO - "script_repo_revision": "production", 22:12:18 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 22:12:18 INFO - "repository": "", 22:12:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 22:12:18 INFO - "buildid": "20160204193034", 22:12:18 INFO - "pgo_build": "True", 22:12:18 INFO - "basedir": "/builds/slave/test-pgo", 22:12:18 INFO - "buildnumber": 183, 22:12:18 INFO - "slavename": "talos-linux64-ix-016", 22:12:18 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:12:18 INFO - "platform": "ubuntu64_hw", 22:12:18 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 22:12:18 INFO - "branch": "mozilla-central", 22:12:18 INFO - "repo_path": "mozilla-central", 22:12:18 INFO - "revision": "5e024441510f6d2b460e570d0e6d2dee0dc89723", 22:12:18 INFO - "stage_platform": "linux64-pgo", 22:12:18 INFO - "builduid": "690138059bcc4e3ab0c9da97a7234e35", 22:12:18 INFO - "slavebuilddir": "test" 22:12:18 INFO - } 22:12:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/bvOsTzIOQ5yMrAOwphA7jw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 22:12:18 INFO - Running post-action listener: _resource_record_post_action 22:12:18 INFO - ##### 22:12:18 INFO - ##### Running download-and-extract step. 22:12:18 INFO - ##### 22:12:18 INFO - Running pre-action listener: _resource_record_pre_action 22:12:18 INFO - Running main action method: download_and_extract 22:12:18 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:12:18 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:18 INFO - https://queue.taskcluster.net/v1/task/bvOsTzIOQ5yMrAOwphA7jw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:12:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bvOsTzIOQ5yMrAOwphA7jw/artifacts/public/build/test_packages.json 22:12:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bvOsTzIOQ5yMrAOwphA7jw/artifacts/public/build/test_packages.json 22:12:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bvOsTzIOQ5yMrAOwphA7jw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 22:12:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bvOsTzIOQ5yMrAOwphA7jw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 22:12:21 INFO - Downloaded 1448 bytes. 22:12:21 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 22:12:21 INFO - Using the following test package requirements: 22:12:21 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 22:12:21 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:12:21 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:12:21 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:12:21 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:12:21 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:12:21 INFO - u'jsshell-linux-x86_64.zip'], 22:12:21 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:12:21 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:12:21 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 22:12:21 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:12:21 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:12:21 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:12:21 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:12:21 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:12:21 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:12:21 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 22:12:21 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:12:21 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:12:21 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:12:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:12:21 INFO - https://queue.taskcluster.net/v1/task/bvOsTzIOQ5yMrAOwphA7jw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:12:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bvOsTzIOQ5yMrAOwphA7jw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:12:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bvOsTzIOQ5yMrAOwphA7jw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:12:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bvOsTzIOQ5yMrAOwphA7jw/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:12:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bvOsTzIOQ5yMrAOwphA7jw/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:12:25 INFO - retry: attempt #1 caught exception: '' 22:12:25 INFO - retry: Failed, sleeping 30 seconds before retrying 22:12:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bvOsTzIOQ5yMrAOwphA7jw/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 #2 22:13:06 INFO - Downloaded 23568872 bytes. 22:13:06 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:13:06 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:13:07 INFO - Return code: 0 22:13:07 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:13:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:07 INFO - https://queue.taskcluster.net/v1/task/bvOsTzIOQ5yMrAOwphA7jw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:13:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bvOsTzIOQ5yMrAOwphA7jw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:13:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bvOsTzIOQ5yMrAOwphA7jw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:13:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bvOsTzIOQ5yMrAOwphA7jw/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:13:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bvOsTzIOQ5yMrAOwphA7jw/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:13:09 INFO - Downloaded 23568872 bytes. 22:13:09 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:13:09 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:13:10 INFO - Return code: 0 22:13:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:10 INFO - https://queue.taskcluster.net/v1/task/bvOsTzIOQ5yMrAOwphA7jw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:13:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bvOsTzIOQ5yMrAOwphA7jw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 22:13:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bvOsTzIOQ5yMrAOwphA7jw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 22:13:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bvOsTzIOQ5yMrAOwphA7jw/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:13:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bvOsTzIOQ5yMrAOwphA7jw/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:13:12 INFO - Downloaded 10706582 bytes. 22:13:12 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:13:12 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:13:12 INFO - Return code: 0 22:13:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:12 INFO - https://queue.taskcluster.net/v1/task/bvOsTzIOQ5yMrAOwphA7jw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:13:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bvOsTzIOQ5yMrAOwphA7jw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:13:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bvOsTzIOQ5yMrAOwphA7jw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:13:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bvOsTzIOQ5yMrAOwphA7jw/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:13:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bvOsTzIOQ5yMrAOwphA7jw/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:13:14 INFO - Downloaded 56418911 bytes. 22:13:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bvOsTzIOQ5yMrAOwphA7jw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:13:14 INFO - mkdir: /builds/slave/test-pgo/properties 22:13:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:13:14 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:13:14 INFO - Contents: 22:13:14 INFO - build_url:https://queue.taskcluster.net/v1/task/bvOsTzIOQ5yMrAOwphA7jw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:13:14 INFO - Running post-action listener: _resource_record_post_action 22:13:14 INFO - Running post-action listener: set_extra_try_arguments 22:13:14 INFO - ##### 22:13:14 INFO - ##### Running populate-webroot step. 22:13:14 INFO - ##### 22:13:14 INFO - Running pre-action listener: _resource_record_pre_action 22:13:14 INFO - Running main action method: populate_webroot 22:13:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:13:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:13:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:13:14 INFO - '--tppagecycles', 22:13:14 INFO - '7'], 22:13:14 INFO - 'tests': ['tsvgm']}}, 22:13:14 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:13:14 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:13:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:13:14 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 22:13:14 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:13:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:13:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:13:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:13:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:13:14 INFO - 'talos_options': ['--e10s'], 22:13:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:13:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:13:14 INFO - 'tests': ['damp', 'tps']}, 22:13:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:13:14 INFO - 'talos_options': ['--e10s'], 22:13:14 INFO - 'tests': ['damp', 'tps']}, 22:13:14 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:13:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:13:14 INFO - 'other': {'tests': ['a11yr', 22:13:14 INFO - 'ts_paint', 22:13:14 INFO - 'tpaint', 22:13:14 INFO - 'sessionrestore', 22:13:14 INFO - 'sessionrestore_no_auto_restore']}, 22:13:14 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:13:14 INFO - 'tests': ['a11yr', 22:13:14 INFO - 'ts_paint', 22:13:14 INFO - 'tpaint', 22:13:14 INFO - 'sessionrestore', 22:13:14 INFO - 'sessionrestore_no_auto_restore']}, 22:13:14 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:13:14 INFO - 'tests': ['a11yr', 22:13:14 INFO - 'ts_paint', 22:13:14 INFO - 'tpaint', 22:13:14 INFO - 'sessionrestore', 22:13:14 INFO - 'sessionrestore_no_auto_restore']}, 22:13:14 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:13:14 INFO - 'tests': ['a11yr', 22:13:14 INFO - 'ts_paint', 22:13:14 INFO - 'tpaint', 22:13:14 INFO - 'sessionrestore', 22:13:14 INFO - 'sessionrestore_no_auto_restore']}, 22:13:14 INFO - 'other_l64': {'tests': ['a11yr', 22:13:14 INFO - 'ts_paint', 22:13:14 INFO - 'tpaint', 22:13:14 INFO - 'sessionrestore', 22:13:14 INFO - 'sessionrestore_no_auto_restore']}, 22:13:14 INFO - 'other_nol64': {'tests': ['a11yr', 22:13:14 INFO - 'ts_paint', 22:13:14 INFO - 'tpaint', 22:13:14 INFO - 'sessionrestore', 22:13:14 INFO - 'sessionrestore_no_auto_restore']}, 22:13:14 INFO - 'svgr': {'tests': ['tsvgx', 22:13:14 INFO - 'tsvgr_opacity', 22:13:14 INFO - 'tart', 22:13:14 INFO - 'tscrollx', 22:13:14 INFO - 'cart']}, 22:13:14 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:13:14 INFO - 'tests': ['tsvgx', 22:13:14 INFO - 'tsvgr_opacity', 22:13:14 INFO - 'tart', 22:13:14 INFO - 'tscrollx', 22:13:14 INFO - 'cart']}, 22:13:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:13:14 INFO - 'tests': ['tp5o']}, 22:13:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:13:14 INFO - 'talos_options': ['--e10s'], 22:13:14 INFO - 'tests': ['tp5o']}, 22:13:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:13:14 INFO - 'talos_options': ['--xperf_path', 22:13:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:13:14 INFO - 'tests': ['tp5n']}, 22:13:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:13:14 INFO - 'talos_options': ['--e10s', 22:13:14 INFO - '--xperf_path', 22:13:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:13:14 INFO - 'tests': ['tp5n']}}, 22:13:14 INFO - 'talos.zip': {'path': '', 22:13:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:13:14 INFO - Running post-action listener: _resource_record_post_action 22:13:14 INFO - ##### 22:13:14 INFO - ##### Running create-virtualenv step. 22:13:14 INFO - ##### 22:13:14 INFO - Running pre-action listener: _resource_record_pre_action 22:13:14 INFO - Running main action method: create_virtualenv 22:13:14 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:13:14 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:13:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:13:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:13:15 INFO - Using real prefix '/usr' 22:13:15 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:13:15 INFO - Installing distribute.............................................................................................................................................................................................done. 22:13:17 INFO - Installing pip.................done. 22:13:17 INFO - Return code: 0 22:13:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:13:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:17 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd12917ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21af630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2240840>, '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 0x21ad6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21adb60>, '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': '00204705a9daa57ed339a427000001b9-1454652072.156634-1829845297', '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:13:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 22:13:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:13:17 INFO - Using env: {'DISPLAY': ':0', 22:13:17 INFO - 'HOME': '/home/cltbld', 22:13:17 INFO - 'LANG': 'en_US.UTF-8', 22:13:17 INFO - 'LANGUAGE': 'en_US:en', 22:13:17 INFO - 'LOGNAME': 'cltbld', 22:13:17 INFO - 'MAIL': '/var/mail/cltbld', 22:13:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:17 INFO - 'MOZ_NO_REMOTE': '1', 22:13:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:17 INFO - 'NO_EM_RESTART': '1', 22:13:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:13:17 INFO - 'PWD': '/builds/slave/test-pgo', 22:13:17 INFO - 'SHELL': '/bin/bash', 22:13:17 INFO - 'SHLVL': '1', 22:13:17 INFO - 'TERM': 'linux', 22:13:17 INFO - 'TMOUT': '86400', 22:13:17 INFO - 'USER': 'cltbld', 22:13:17 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1454652072.156634-1829845297', 22:13:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:17 INFO - '_': '/tools/buildbot/bin/python'} 22:13:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:17 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:13:17 INFO - Cleaning up... 22:13:17 INFO - Return code: 0 22:13:17 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:13:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:17 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd12917ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21af630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2240840>, '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 0x21ad6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21adb60>, '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': '00204705a9daa57ed339a427000001b9-1454652072.156634-1829845297', '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:13:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 22:13:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 22:13:17 INFO - Using env: {'DISPLAY': ':0', 22:13:17 INFO - 'HOME': '/home/cltbld', 22:13:17 INFO - 'LANG': 'en_US.UTF-8', 22:13:17 INFO - 'LANGUAGE': 'en_US:en', 22:13:17 INFO - 'LOGNAME': 'cltbld', 22:13:17 INFO - 'MAIL': '/var/mail/cltbld', 22:13:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:17 INFO - 'MOZ_NO_REMOTE': '1', 22:13:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:17 INFO - 'NO_EM_RESTART': '1', 22:13:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:13:17 INFO - 'PWD': '/builds/slave/test-pgo', 22:13:17 INFO - 'SHELL': '/bin/bash', 22:13:17 INFO - 'SHLVL': '1', 22:13:17 INFO - 'TERM': 'linux', 22:13:17 INFO - 'TMOUT': '86400', 22:13:17 INFO - 'USER': 'cltbld', 22:13:17 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1454652072.156634-1829845297', 22:13:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:17 INFO - '_': '/tools/buildbot/bin/python'} 22:13:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:18 INFO - Downloading/unpacking psutil>=0.7.1 22:13:18 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:13:18 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:13:18 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:13:18 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:13:18 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:13:18 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:13:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:13:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:13:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:13:20 INFO - Installing collected packages: psutil 22:13:20 INFO - Running setup.py install for psutil 22:13:20 INFO - building 'psutil._psutil_linux' extension 22:13:20 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:13:20 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:13:20 INFO - building 'psutil._psutil_posix' extension 22:13:20 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:13:20 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:13:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:13:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:13:20 INFO - Successfully installed psutil 22:13:20 INFO - Cleaning up... 22:13:20 INFO - Return code: 0 22:13:20 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:13:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:20 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 0x7fd12917ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21af630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2240840>, '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 0x21ad6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21adb60>, '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': '00204705a9daa57ed339a427000001b9-1454652072.156634-1829845297', '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:13:20 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:13:20 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:13:20 INFO - Using env: {'DISPLAY': ':0', 22:13:20 INFO - 'HOME': '/home/cltbld', 22:13:20 INFO - 'LANG': 'en_US.UTF-8', 22:13:20 INFO - 'LANGUAGE': 'en_US:en', 22:13:20 INFO - 'LOGNAME': 'cltbld', 22:13:20 INFO - 'MAIL': '/var/mail/cltbld', 22:13:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:20 INFO - 'MOZ_NO_REMOTE': '1', 22:13:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:20 INFO - 'NO_EM_RESTART': '1', 22:13:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:13:20 INFO - 'PWD': '/builds/slave/test-pgo', 22:13:20 INFO - 'SHELL': '/bin/bash', 22:13:20 INFO - 'SHLVL': '1', 22:13:20 INFO - 'TERM': 'linux', 22:13:20 INFO - 'TMOUT': '86400', 22:13:20 INFO - 'USER': 'cltbld', 22:13:20 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1454652072.156634-1829845297', 22:13:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:20 INFO - '_': '/tools/buildbot/bin/python'} 22:13:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:20 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:13:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:13:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:13:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:22 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:13:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:13:22 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:13:22 INFO - Installing collected packages: mozsystemmonitor 22:13:22 INFO - Running setup.py install for mozsystemmonitor 22:13:22 INFO - Successfully installed mozsystemmonitor 22:13:22 INFO - Cleaning up... 22:13:23 INFO - Return code: 0 22:13:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:13:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:23 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 0x7fd12917ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21af630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2240840>, '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 0x21ad6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21adb60>, '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': '00204705a9daa57ed339a427000001b9-1454652072.156634-1829845297', '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:13:23 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:13:23 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:13:23 INFO - Using env: {'DISPLAY': ':0', 22:13:23 INFO - 'HOME': '/home/cltbld', 22:13:23 INFO - 'LANG': 'en_US.UTF-8', 22:13:23 INFO - 'LANGUAGE': 'en_US:en', 22:13:23 INFO - 'LOGNAME': 'cltbld', 22:13:23 INFO - 'MAIL': '/var/mail/cltbld', 22:13:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:23 INFO - 'MOZ_NO_REMOTE': '1', 22:13:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:23 INFO - 'NO_EM_RESTART': '1', 22:13:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:13:23 INFO - 'PWD': '/builds/slave/test-pgo', 22:13:23 INFO - 'SHELL': '/bin/bash', 22:13:23 INFO - 'SHLVL': '1', 22:13:23 INFO - 'TERM': 'linux', 22:13:23 INFO - 'TMOUT': '86400', 22:13:23 INFO - 'USER': 'cltbld', 22:13:23 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1454652072.156634-1829845297', 22:13:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:23 INFO - '_': '/tools/buildbot/bin/python'} 22:13:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:23 INFO - Downloading/unpacking blobuploader==1.2.4 22:13:23 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:13:23 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:13:23 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:13:23 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:13:23 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:13:23 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:13:25 INFO - Downloading blobuploader-1.2.4.tar.gz 22:13:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:13:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:13:25 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:13:25 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:13:25 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:13:25 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:13:25 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:13:25 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:13:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:13:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:13:25 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:13:25 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:13:25 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:13:25 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:13:25 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:13:25 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:13:25 INFO - Downloading docopt-0.6.1.tar.gz 22:13:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:13:25 INFO - Installing collected packages: blobuploader, requests, docopt 22:13:25 INFO - Running setup.py install for blobuploader 22:13:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:13:25 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:13:25 INFO - Running setup.py install for requests 22:13:26 INFO - Running setup.py install for docopt 22:13:26 INFO - Successfully installed blobuploader requests docopt 22:13:26 INFO - Cleaning up... 22:13:26 INFO - Return code: 0 22:13:26 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:13: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:13:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13: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:13:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:26 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 0x7fd12917ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21af630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2240840>, '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 0x21ad6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21adb60>, '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': '00204705a9daa57ed339a427000001b9-1454652072.156634-1829845297', '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:13:26 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:13:26 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:13:26 INFO - Using env: {'DISPLAY': ':0', 22:13:26 INFO - 'HOME': '/home/cltbld', 22:13:26 INFO - 'LANG': 'en_US.UTF-8', 22:13:26 INFO - 'LANGUAGE': 'en_US:en', 22:13:26 INFO - 'LOGNAME': 'cltbld', 22:13:26 INFO - 'MAIL': '/var/mail/cltbld', 22:13:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:26 INFO - 'MOZ_NO_REMOTE': '1', 22:13:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:26 INFO - 'NO_EM_RESTART': '1', 22:13:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:13:26 INFO - 'PWD': '/builds/slave/test-pgo', 22:13:26 INFO - 'SHELL': '/bin/bash', 22:13:26 INFO - 'SHLVL': '1', 22:13:26 INFO - 'TERM': 'linux', 22:13:26 INFO - 'TMOUT': '86400', 22:13:26 INFO - 'USER': 'cltbld', 22:13:26 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1454652072.156634-1829845297', 22:13:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:26 INFO - '_': '/tools/buildbot/bin/python'} 22:13:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:13:26 INFO - Running setup.py (path:/tmp/pip-Dq4rHl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:13:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:13:26 INFO - Running setup.py (path:/tmp/pip-Lo8k05-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:13:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:13:26 INFO - Running setup.py (path:/tmp/pip-6riRf2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:13:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:13:26 INFO - Running setup.py (path:/tmp/pip-cxdMq7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:13:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:13:26 INFO - Running setup.py (path:/tmp/pip-_UCGDZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:13:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:13:26 INFO - Running setup.py (path:/tmp/pip-X4i_v9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:13:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:13:27 INFO - Running setup.py (path:/tmp/pip-b4lXMc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:13:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:13:27 INFO - Running setup.py (path:/tmp/pip-wvspEk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:13:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:13:27 INFO - Running setup.py (path:/tmp/pip-tuuJum-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:13:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:13:27 INFO - Running setup.py (path:/tmp/pip-xW5pje-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:13:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:13:27 INFO - Running setup.py (path:/tmp/pip-7_tGN6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:13:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:13:27 INFO - Running setup.py (path:/tmp/pip-CdzdOK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:13:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:13:27 INFO - Running setup.py (path:/tmp/pip-KSOuZg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:13:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:13:27 INFO - Running setup.py (path:/tmp/pip-bNWPbf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:13:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:13:27 INFO - Running setup.py (path:/tmp/pip-TmJogq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:13:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:13:27 INFO - Running setup.py (path:/tmp/pip-PgvzeV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:13:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:13:27 INFO - Running setup.py (path:/tmp/pip-JOFP8_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:13:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:13:27 INFO - Running setup.py install for manifestparser 22:13:27 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:13:27 INFO - Running setup.py install for mozcrash 22:13:28 INFO - Running setup.py install for mozdebug 22:13:28 INFO - Running setup.py install for mozdevice 22:13:28 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:13:28 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:13:28 INFO - Running setup.py install for mozfile 22:13:28 INFO - Running setup.py install for mozhttpd 22:13:28 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:13:28 INFO - Running setup.py install for mozinfo 22:13:28 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:13:28 INFO - Running setup.py install for mozInstall 22:13:28 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:13:28 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:13:28 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:13:28 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:13:28 INFO - Running setup.py install for mozleak 22:13:28 INFO - Running setup.py install for mozlog 22:13:28 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:13:28 INFO - Running setup.py install for moznetwork 22:13:28 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:13:28 INFO - Running setup.py install for mozprocess 22:13:29 INFO - Running setup.py install for mozprofile 22:13:29 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:13:29 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:13:29 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:13:29 INFO - Running setup.py install for mozrunner 22:13:29 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:13:29 INFO - Running setup.py install for mozscreenshot 22:13:29 INFO - Running setup.py install for moztest 22:13:29 INFO - Running setup.py install for mozversion 22:13:29 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:13:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:13:29 INFO - Cleaning up... 22:13:29 INFO - Return code: 0 22:13:29 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:13: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:13:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13: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:13:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:29 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 0x7fd12917ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21af630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2240840>, '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 0x21ad6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21adb60>, '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': '00204705a9daa57ed339a427000001b9-1454652072.156634-1829845297', '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:13:29 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:13:29 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:13:29 INFO - Using env: {'DISPLAY': ':0', 22:13:29 INFO - 'HOME': '/home/cltbld', 22:13:29 INFO - 'LANG': 'en_US.UTF-8', 22:13:29 INFO - 'LANGUAGE': 'en_US:en', 22:13:29 INFO - 'LOGNAME': 'cltbld', 22:13:29 INFO - 'MAIL': '/var/mail/cltbld', 22:13:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:29 INFO - 'MOZ_NO_REMOTE': '1', 22:13:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:29 INFO - 'NO_EM_RESTART': '1', 22:13:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:13:29 INFO - 'PWD': '/builds/slave/test-pgo', 22:13:29 INFO - 'SHELL': '/bin/bash', 22:13:29 INFO - 'SHLVL': '1', 22:13:29 INFO - 'TERM': 'linux', 22:13:29 INFO - 'TMOUT': '86400', 22:13:29 INFO - 'USER': 'cltbld', 22:13:29 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1454652072.156634-1829845297', 22:13:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:29 INFO - '_': '/tools/buildbot/bin/python'} 22:13:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:13:29 INFO - Running setup.py (path:/tmp/pip-mOVcUu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:13:29 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:13:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:13:29 INFO - Running setup.py (path:/tmp/pip-Ovxtk5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:13:29 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:13:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:13:29 INFO - Running setup.py (path:/tmp/pip-wni9L8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:13:30 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:13:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:13:30 INFO - Running setup.py (path:/tmp/pip-6J4nDp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:13:30 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:13:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:13:30 INFO - Running setup.py (path:/tmp/pip-GT0kJM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:13:30 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:13:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:13:30 INFO - Running setup.py (path:/tmp/pip-uUM8qJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:13:30 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:13:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:13:30 INFO - Running setup.py (path:/tmp/pip-OpDfox-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:13:30 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:13:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:13:30 INFO - Running setup.py (path:/tmp/pip-JClGjs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:13:30 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:13:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:13:30 INFO - Running setup.py (path:/tmp/pip-DHkf7H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:13:30 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:13:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:13:30 INFO - Running setup.py (path:/tmp/pip-VfTgnq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:13:30 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:13:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:13:30 INFO - Running setup.py (path:/tmp/pip-CWcgh2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:13:30 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:13:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:13:30 INFO - Running setup.py (path:/tmp/pip-d5JMtd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:13:30 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:13:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:13:30 INFO - Running setup.py (path:/tmp/pip-lFIFkq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:13:30 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:13:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:13:30 INFO - Running setup.py (path:/tmp/pip-H0RnHT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:13:30 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:13:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:13:30 INFO - Running setup.py (path:/tmp/pip-HjvWvo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:13:30 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:13:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:13:30 INFO - Running setup.py (path:/tmp/pip-8xLgLf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:13:31 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:13:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:13:31 INFO - Running setup.py (path:/tmp/pip-zqKJF1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:13:31 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:13:31 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:13:31 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:13:31 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:13:31 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:13:31 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:13:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:13:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:13:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:13:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:32 INFO - Downloading blessings-1.6.tar.gz 22:13:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:13:32 INFO - Installing collected packages: blessings 22:13:32 INFO - Running setup.py install for blessings 22:13:33 INFO - Successfully installed blessings 22:13:33 INFO - Cleaning up... 22:13:33 INFO - Return code: 0 22:13:33 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:13:33 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:13:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:13:33 INFO - Reading from file tmpfile_stdout 22:13:33 INFO - Current package versions: 22:13:33 INFO - argparse == 1.2.1 22:13:33 INFO - blessings == 1.6 22:13:33 INFO - blobuploader == 1.2.4 22:13:33 INFO - docopt == 0.6.1 22:13:33 INFO - manifestparser == 1.1 22:13:33 INFO - mozInstall == 1.12 22:13:33 INFO - mozcrash == 0.16 22:13:33 INFO - mozdebug == 0.1 22:13:33 INFO - mozdevice == 0.48 22:13:33 INFO - mozfile == 1.2 22:13:33 INFO - mozhttpd == 0.7 22:13:33 INFO - mozinfo == 0.9 22:13:33 INFO - mozleak == 0.1 22:13:33 INFO - mozlog == 3.1 22:13:33 INFO - moznetwork == 0.27 22:13:33 INFO - mozprocess == 0.22 22:13:33 INFO - mozprofile == 0.28 22:13:33 INFO - mozrunner == 6.11 22:13:33 INFO - mozscreenshot == 0.1 22:13:33 INFO - mozsystemmonitor == 0.0 22:13:33 INFO - moztest == 0.7 22:13:33 INFO - mozversion == 1.4 22:13:33 INFO - psutil == 3.1.1 22:13:33 INFO - requests == 1.2.3 22:13:33 INFO - wsgiref == 0.1.2 22:13:33 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:13: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:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13: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:13:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:33 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 0x7fd12917ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21af630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2240840>, '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 0x21ad6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21adb60>, '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': '00204705a9daa57ed339a427000001b9-1454652072.156634-1829845297', '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:13:33 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:13:33 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:13:33 INFO - Using env: {'DISPLAY': ':0', 22:13:33 INFO - 'HOME': '/home/cltbld', 22:13:33 INFO - 'LANG': 'en_US.UTF-8', 22:13:33 INFO - 'LANGUAGE': 'en_US:en', 22:13:33 INFO - 'LOGNAME': 'cltbld', 22:13:33 INFO - 'MAIL': '/var/mail/cltbld', 22:13:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:33 INFO - 'MOZ_NO_REMOTE': '1', 22:13:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:33 INFO - 'NO_EM_RESTART': '1', 22:13:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:13:33 INFO - 'PWD': '/builds/slave/test-pgo', 22:13:33 INFO - 'SHELL': '/bin/bash', 22:13:33 INFO - 'SHLVL': '1', 22:13:33 INFO - 'TERM': 'linux', 22:13:33 INFO - 'TMOUT': '86400', 22:13:33 INFO - 'USER': 'cltbld', 22:13:33 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1454652072.156634-1829845297', 22:13:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:33 INFO - '_': '/tools/buildbot/bin/python'} 22:13:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:33 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:13:33 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:13:33 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:13:33 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:13:33 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:13:33 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:13:33 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:13:33 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:13:33 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:13:33 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:13:33 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:13:33 INFO - Cleaning up... 22:13:33 INFO - Return code: 0 22:13:33 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:13: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:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13: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:13:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:33 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd12917ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21af630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2240840>, '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 0x21ad6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21adb60>, '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': '00204705a9daa57ed339a427000001b9-1454652072.156634-1829845297', '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:13:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 22:13:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:13:33 INFO - Using env: {'DISPLAY': ':0', 22:13:33 INFO - 'HOME': '/home/cltbld', 22:13:33 INFO - 'LANG': 'en_US.UTF-8', 22:13:33 INFO - 'LANGUAGE': 'en_US:en', 22:13:33 INFO - 'LOGNAME': 'cltbld', 22:13:33 INFO - 'MAIL': '/var/mail/cltbld', 22:13:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:33 INFO - 'MOZ_NO_REMOTE': '1', 22:13:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:33 INFO - 'NO_EM_RESTART': '1', 22:13:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:13:33 INFO - 'PWD': '/builds/slave/test-pgo', 22:13:33 INFO - 'SHELL': '/bin/bash', 22:13:33 INFO - 'SHLVL': '1', 22:13:33 INFO - 'TERM': 'linux', 22:13:33 INFO - 'TMOUT': '86400', 22:13:33 INFO - 'USER': 'cltbld', 22:13:33 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1454652072.156634-1829845297', 22:13:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:33 INFO - '_': '/tools/buildbot/bin/python'} 22:13:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:33 INFO - Downloading/unpacking jsonschema 22:13:33 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:13:33 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:13:33 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:13:33 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:13:33 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:13:33 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:13:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:13:35 INFO - Downloading/unpacking functools32 (from jsonschema) 22:13:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:13:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:13:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:35 INFO - Downloading functools32-3.2.3-2.tar.gz 22:13:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:13:35 INFO - warning: no files found matching '*.txt' 22:13:35 INFO - no previously-included directories found matching 'build' 22:13:35 INFO - no previously-included directories found matching 'dist' 22:13:35 INFO - no previously-included directories found matching '.git*' 22:13:35 INFO - Installing collected packages: jsonschema, functools32 22:13:35 INFO - Running setup.py install for functools32 22:13:35 INFO - warning: no files found matching '*.txt' 22:13:35 INFO - no previously-included directories found matching 'build' 22:13:35 INFO - no previously-included directories found matching 'dist' 22:13:35 INFO - no previously-included directories found matching '.git*' 22:13:35 INFO - Successfully installed jsonschema functools32 22:13:35 INFO - Cleaning up... 22:13:35 INFO - Return code: 0 22:13:35 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:13:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:35 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd12917ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21af630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2240840>, '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 0x21ad6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21adb60>, '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': '00204705a9daa57ed339a427000001b9-1454652072.156634-1829845297', '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:13:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 22:13:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:13:35 INFO - Using env: {'DISPLAY': ':0', 22:13:35 INFO - 'HOME': '/home/cltbld', 22:13:35 INFO - 'LANG': 'en_US.UTF-8', 22:13:35 INFO - 'LANGUAGE': 'en_US:en', 22:13:35 INFO - 'LOGNAME': 'cltbld', 22:13:35 INFO - 'MAIL': '/var/mail/cltbld', 22:13:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:35 INFO - 'MOZ_NO_REMOTE': '1', 22:13:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:35 INFO - 'NO_EM_RESTART': '1', 22:13:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:13:35 INFO - 'PWD': '/builds/slave/test-pgo', 22:13:35 INFO - 'SHELL': '/bin/bash', 22:13:35 INFO - 'SHLVL': '1', 22:13:35 INFO - 'TERM': 'linux', 22:13:35 INFO - 'TMOUT': '86400', 22:13:35 INFO - 'USER': 'cltbld', 22:13:35 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1454652072.156634-1829845297', 22:13:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:35 INFO - '_': '/tools/buildbot/bin/python'} 22:13:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:36 INFO - Downloading/unpacking flake8 22:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:13:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:37 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:13:37 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:13:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:13:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:13:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:38 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:13:38 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:13: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:13: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:13: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:13: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:13: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:13: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:13:38 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:13: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:13: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:13: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:13: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:13: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:13: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:13:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:13:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:13:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:13:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:13:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:13:38 INFO - no previously-included directories found matching 'docs/_build' 22:13:38 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:13:38 INFO - Running setup.py install for pep8 22:13:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:13:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:13:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:13:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:13:38 INFO - no previously-included directories found matching 'docs/_build' 22:13:38 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:13:38 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:13:38 INFO - Cleaning up... 22:13:38 INFO - Return code: 0 22:13:38 INFO - Running post-action listener: _resource_record_post_action 22:13:38 INFO - Running post-action listener: _start_resource_monitoring 22:13:38 INFO - Starting resource monitoring. 22:13:38 INFO - ##### 22:13:38 INFO - ##### Running install step. 22:13:38 INFO - ##### 22:13:38 INFO - Running pre-action listener: _resource_record_pre_action 22:13:38 INFO - Running main action method: install 22:13:38 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:13:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:13:39 INFO - Reading from file tmpfile_stdout 22:13:39 INFO - Detecting whether we're running mozinstall >=1.0... 22:13:39 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:13:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:13:39 INFO - Reading from file tmpfile_stdout 22:13:39 INFO - Output received: 22:13:39 INFO - Usage: mozinstall [options] installer 22:13:39 INFO - Options: 22:13:39 INFO - -h, --help show this help message and exit 22:13:39 INFO - -d DEST, --destination=DEST 22:13:39 INFO - Directory to install application into. [default: 22:13:39 INFO - "/builds/slave/test-pgo"] 22:13:39 INFO - --app=APP Application being installed. [default: firefox] 22:13:39 INFO - mkdir: /builds/slave/test-pgo/build/application 22:13:39 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:13:39 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:13:55 INFO - Reading from file tmpfile_stdout 22:13:55 INFO - Output received: 22:13:55 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:13:55 INFO - Running post-action listener: _resource_record_post_action 22:13:55 INFO - ##### 22:13:55 INFO - ##### Running run-tests step. 22:13:55 INFO - ##### 22:13:55 INFO - Running pre-action listener: _resource_record_pre_action 22:13:55 INFO - Running main action method: run_tests 22:13:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:13:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:13:55 INFO - Python 2.7.3 22:13:55 INFO - Return code: 0 22:13:55 INFO - grabbing minidump binary from tooltool 22:13:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:55 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 0x2240840>, '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 0x21ad6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21adb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:13:55 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 22:13:55 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 22:13:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:13:55 INFO - Return code: 0 22:13:55 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:13:55 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:13:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:13:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:13:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:13:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:13:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:13:56 INFO - Return code: 0 22:13:56 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/bvOsTzIOQ5yMrAOwphA7jw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 22:13:56 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/bvOsTzIOQ5yMrAOwphA7jw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 22:13:56 INFO - Using env: {'DISPLAY': ':0', 22:13:56 INFO - 'HOME': '/home/cltbld', 22:13:56 INFO - 'LANG': 'en_US.UTF-8', 22:13:56 INFO - 'LANGUAGE': 'en_US:en', 22:13:56 INFO - 'LOGNAME': 'cltbld', 22:13:56 INFO - 'MAIL': '/var/mail/cltbld', 22:13:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:13:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:13:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:56 INFO - 'MOZ_NO_REMOTE': '1', 22:13:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:13:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:56 INFO - 'NO_EM_RESTART': '1', 22:13:56 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:13:56 INFO - 'PWD': '/builds/slave/test-pgo', 22:13:56 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:13:56 INFO - 'SHELL': '/bin/bash', 22:13:56 INFO - 'SHLVL': '1', 22:13:56 INFO - 'TERM': 'linux', 22:13:56 INFO - 'TMOUT': '86400', 22:13:56 INFO - 'USER': 'cltbld', 22:13:56 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1454652072.156634-1829845297', 22:13:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:56 INFO - '_': '/tools/buildbot/bin/python'} 22:13:56 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/bvOsTzIOQ5yMrAOwphA7jw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 22:13:56 INFO - mozversion application_buildid: 20160204193034 22:13:56 INFO - mozversion application_changeset: 5e024441510f6d2b460e570d0e6d2dee0dc89723 22:13:56 INFO - mozversion application_display_name: Nightly 22:13:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:13:56 INFO - mozversion application_name: Firefox 22:13:56 INFO - mozversion application_remotingname: firefox 22:13:56 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 22:13:56 INFO - mozversion application_vendor: Mozilla 22:13:56 INFO - mozversion application_version: 47.0a1 22:13:56 INFO - mozversion platform_buildid: 20160204193034 22:13:56 INFO - mozversion platform_changeset: 5e024441510f6d2b460e570d0e6d2dee0dc89723 22:13:56 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 22:13:56 INFO - mozversion platform_version: 47.0a1 22:13:56 INFO - using testdate: 1454652836 22:13:56 INFO - actual date: 1454652836 22:13:56 INFO - starting webserver on 'localhost:52961' 22:13:56 INFO - SUITE-START | Running 2 tests 22:13:56 INFO - TEST-START | dromaeo_css 22:13:56 INFO - operating with platform_type : linux_ 22:13:56 INFO - Initialising browser for dromaeo_css test... 22:13:56 INFO - TEST-INFO | started process 3943 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpny6cZe/profile http://localhost:52961/getInfo.html) 22:13:57 INFO - PROCESS | 3943 | JavaScript warning: resource://gre/modules/AddonManager.jsm, line 692: Proxy.create and Proxy.createFunction are deprecated, use new Proxy instead 22:14:01 INFO - PROCESS | 3943 | __metrics Screen width/height:1600/1200 22:14:01 INFO - PROCESS | 3943 | colorDepth:24 22:14:01 INFO - PROCESS | 3943 | Browser inner width/height: 1024/697 22:14:01 INFO - PROCESS | 3943 | __metrics 22:14:01 INFO - PROCESS | 3943 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:14:02 INFO - TEST-INFO | 3943: exit 0 22:14:02 INFO - Browser initialized. 22:14:02 INFO - Running cycle 1/1 for dromaeo_css test... 22:14:02 INFO - TEST-INFO | started process 4036 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpny6cZe/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:14:14 INFO - PROCESS | 4036 | RSS: Main: 151654400 22:14:14 INFO - PROCESS | 4036 | 22:15:06 INFO - PROCESS | 4036 | 1454652906034 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:17:13 INFO - PROCESS | 4036 | Cycle 1(1): loaded http://localhost:52961/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52961/tests/dromaeo/cssquery-ext.html) 22:17:15 INFO - PROCESS | 4036 | RSS: Main: 340033536 22:17:15 INFO - PROCESS | 4036 | 22:20:18 INFO - PROCESS | 4036 | Cycle 1(1): loaded http://localhost:52961/tests/dromaeo/cssquery-ext.html (next: http://localhost:52961/tests/dromaeo/cssquery-jquery.html) 22:20:18 INFO - PROCESS | 4036 | RSS: Main: 232493056 22:20:18 INFO - PROCESS | 4036 | 22:23:20 INFO - PROCESS | 4036 | Cycle 1(1): loaded http://localhost:52961/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52961/tests/dromaeo/cssquery-mootools.html) 22:23:21 INFO - PROCESS | 4036 | RSS: Main: 224993280 22:23:21 INFO - PROCESS | 4036 | 22:26:23 INFO - PROCESS | 4036 | Cycle 1(1): loaded http://localhost:52961/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52961/tests/dromaeo/cssquery-prototype.html) 22:26:23 INFO - PROCESS | 4036 | RSS: Main: 217145344 22:26:23 INFO - PROCESS | 4036 | 22:29:26 INFO - PROCESS | 4036 | Cycle 1(1): loaded http://localhost:52961/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52961/tests/dromaeo/cssquery-yui.html) 22:29:26 INFO - PROCESS | 4036 | RSS: Main: 216723456 22:29:26 INFO - PROCESS | 4036 | 22:32:29 INFO - PROCESS | 4036 | Cycle 1(1): loaded http://localhost:52961/tests/dromaeo/cssquery-yui.html (next: http://localhost:52961/tests/dromaeo/cssquery-dojo.html) 22:32:29 INFO - PROCESS | 4036 | RSS: Main: 295682048 22:32:29 INFO - PROCESS | 4036 | 22:32:29 INFO - PROCESS | 4036 | __start_tp_report 22:32:29 INFO - PROCESS | 4036 | _x_x_mozilla_page_load 22:32:29 INFO - PROCESS | 4036 | _x_x_mozilla_page_load_details 22:32:29 INFO - PROCESS | 4036 | |i|pagename|runs| 22:32:29 INFO - PROCESS | 4036 | |0;dojo.html;3165.066305439895;3192.170035790694;3225.8064516129034;3227.2254658881875;3251.1872031991993;5090.211017292317;5136.486351364862;5148.195041223441;5198.766055527505;5243.2659427680155;5171.198464238049;5206.661566998143;5228.660137091087;5256.763445644946;5284.233786101013;4704.929426058612;4716.740579268139;4727.858164255078;4743.335932969387;4882.731449770279;4822.734749588772;4837.080954618629;4850.514948505156;4859.392575928009;4873.098476781789;4740.170470167707;4760.904781904343;4817.9759101204445;4820.301056346845;4879.780409881564;4774.021325628238;4779.784909679038;4783.976080119612;4802.687825291345;4814.494478079786;4725.952740472586;4731.313959475891;4735.100330937111;4746;4757.476677565465;5047;5084.339035925306;5084.389873215201;5154.07226699194;5204.531592156686;5592.217089607418;5617.045102332613;5618.57860660448;5624.71876406178;5631.521320687746;5655.264815573949;5661.575381846337;5674.120511320752;5676.347220069662;5684.37471878093;5175.353080864892;5249.4488078751565;5250.18622113573;5250.632455728062;5344.171653393731;5721.199032135504;5730.828075157752;5736.225609542742;5740.081586946152;5785.82642520725;5522.199281104217;5530.5022547970875;5531;5531.529819965268;5534.640248383842;5616.269884914935;5660;5706.42935706426;5707.200991861143;5748.13777933305;5457.5633949283965;5498.202760599771;5498.890022199614;5503.669779813224;5504.146857237135;5461.262729531462;5507.889842203133;5509.146082357241;5511.366192887869;5542.972285138549;4184.811683474251;4230.111676547898;4266.445362102907;4276.807543660543;4287.914241715211;3784.394496880486;3787.5644300905747;3789.090618251655;3819.6753275971296;3833.4058220975794;5178.6116041297055;5180.533751962342;5192.7403629818355;5194.3766747990485;5250.422453530108;5517.089680202802;5598.356189038232;5600.60795744294;5602.4957753802355;5616.522595579421;5166.974165129151;5181.766820493087;5184.818531351385;5186;5194.0910340690225;4755.9286610700865;4759.619230461555;4760.024195040009;4763.642726795504;4799.016201678647;5749.425057494217;5784.8264552062665;5813.098969659625;5819.970900145472;5835.35811060783;5572.637778544382;5573.665580065209;5574.77700891976;5577;5605.271314729059;5756.913646295393;5775.855603609775;5778.653280803165;5781.479666829838;5782.2483077199695;5546.750396232099;5564.638298510584;5628.971855140698;5632.352279487911;5640.32316122068;5557.166425036277;5593.776248949996;5594.104943209067;5596.888062238814;5600.215969764155;5467.781288748405;5468.671879687232;5469.015577196143;5471.343438787212;5487.917681234864;5447.155690867922;5452.509274165344;5453.918191227214;5470.863228419322;5508.697021663847;5453.127499600045;5459.962607104638;5470;5470.398256191896;5509.311336082989;5567.526760225426;5574.637648552831;5575.665460072409;5576.442355764391;5578.079616863172;5359.946400535945;5426.403095659553;5430.8099216527235;5441.809536666197;5501.669899806025 22:32:29 INFO - PROCESS | 4036 | |1;ext.html;531.0838803064711;556.8858384031269;561.3993027460616;562.6258538072182;607.4866737606723;28935.276618084532;29432.411351772953;36612.81693591532;37243.441348379725;37293.44059839105;40413.39379909296;40428.59571404285;40680;40703.79648101763;40782.59217407825;8430.07269200386;8579.142085791433;8631.43895646784;8637.136286371375;8637.438566493158;8386;8552.828943421127;8569;8572.314214862796;8573.014103378098;8708.390412671115;8751;8775.473471591693;8778.341624378165;8779.473231606093;8682.609282582267;8731.170538798804;8737.519436430994;8741.7814554636;8752.993405758323;8687.435316704394;8803.691870784556;8819.250363719091;8819.338549608805;8819.603117859648;40506.594934050576;41016.38475422871;41062.794686026675;41068.794656026825;41107.38338924918;3340.682635149657;3500.597431295408;3544.3620148373284;3754.511913451261;3880.553736320331;28838.134855954355;30669.53995690044;31159.688403115906;31233.37533249345;31508.527372089437;3350.1457128432094;3769.246150769857;3912.589178136283;3978.244133614604;4001.639852413297;282719;284470;284872.57563712256;285463;285781;52978.470215297355;61961;62146;62434.37565624285;62502.37497625056;49113;49116;49141.26288105681;49281.50718492841;66323;14517.85482145165;14815.18516481604;14948.40206391754;14957.925210373878;14958;11223;11291.153163512769;11323.660290191307;11324.6036388726;11387.316760994367;16553.917230414012;16748.246328914985;19637.60724785496;20209.191632334543;20757.37727868136;7496.287852653989;7638.694452221849;7666.233376662401;7769.961150194213;7836;876.3339861705023;907.4328544659588;961.6393852305386;1007.5717819926502;1053.8103141434615;29478.705212947596;29962.400751985275;30159.849200753855;30560.69439305623;30665.386692266475;1036.259074761549;1043.415687215162;1047.1936608811325;1083.149727463937;1171.5899435197782;15451.459198927983;15804.209789510478;16003.119828409317;16092.51722448305;16730.74903876443;385720;390487;391324;393154;393629;55236.44763552313;55910.72044639832;55936.720316398154;55984.16023759647;56091.15863262054;1268.7779638563215;1270.7394984028251;1277.4123903004722;1284.6017734502148;1294.9223046617233;29946.550801737554;31288.257791358577;31347.686523135388;31589.8420507896;31731;46305.53694463147;46792;46817.297740533235;46914;46936;225035;227363;227504;228142;228375;28342;28577.428451430438;31882.52176217405;33032.17419564434;33433.33133337271;38967.610323897534;39460.2107957845;46865.76567117142;48357.75821120872;48844.26733598928;34477.82761086179;34616.82691586526;34721;34970.30059398849;35445.64554354423;35074.29851402907;35272.29455410826;35416.46875296821;35458;35594;35271.294574108884;35884.461733074546;35970.558894618596;37515.81242093772;38816.41775373315;31510.52734208943;35784.46323305101;35954.8202258987;36001;37914.43128353132;26054.86972565201;26591.468170636865;26682.46635067249;27139.72860271451;28767.5684864723 22:32:29 INFO - PROCESS | 4036 | |2;jquery.html;353.7223279725415;355.69410307135877;359.5020896058958;360.7402670077543;363.9090227443139;13573.321333933312;13785.862141378584;16263.674726505478;17411.390601328956;18297.35959241427;15794.763078553802;15896.410358964098;16376.918115409406;16379.344826206967;16393.60654344382;4666.976665116678;4819.156647586676;4838.782254798542;4876.390451193601;4878.585320247783;3735.1969326594776;3866.8646597369097;4845.515448455161;4882.2432522959;5159.871003224931;5247.2653828464045;5248;5249.212618107276;5282.947170528284;5312.814051508198;5426.8914621707545;5685.800996965107;5866.032104702719;5873.588848780587;5882.588218824684;4957.256411538262;5128.8461346159675;5151.0470562945975;5162.354705661793;5164.122099243138;11502.769944601061;11673.824892626617;11745.4714537846;14122.505712300122;20095.598088038158;2045.6215600114026;2067.6795096760025;2089.059923034625;2135.6689713094497;2178.6514157734687;9095.226905712956;9327.13457308541;9360.578773955189;9378.109079637423;9585.856212156823;1829.3780114761046;1863.9906800466047;1870.7568016157948;1907.3229003703625;1913.0912816412233;57138;58618.12072818868;60095.39904600986;60192.796144077314;61010;9552.37909535878;9617.71146865595;9677.806443871224;9695.951520242495;9777.706668799947;12397.814032789516;12505.49978000888;12558.183718058479;12559.623211303675;12593;6912.205096413876;7036.859262814715;7037.788866334018;7073.964630176816;7105.396041336441;6825.1809782825385;6851.520393572502;6856.348646878539;6877.862442751217;6917.169939607179;4088.8568900088353;4123.628873401408;4145.2124096421585;4208.936865947013;4429.291313389842;1578.8500092491195;1639.4507839873777;1639.9098049607148;1671.5319710481085;1697.7623132761423;447.72688659917424;459.91491574058904;930.6742640075919;1009.5255230041869;1025.6922923123034;10398.532066056894;10567.735806604896;10782.245242833083;10791.6222932197;10886.29239099456;457.43506769140083;462.73624034300127;465.51353835242253;484.91271571116835;892.9508877011697;8757.56212189388;9526.285528585384;9571.473568953774;9970.601175952881;10039.297249192487;351897;355291;357425;547303.006214409;549343;72713.6364318175;73810.63094684492;73833;76757;77104.61447692725;1173.7065733566608;1173.9589114380956;1224.1125184241355;1227.9930457025332;1246.5948566715854;15898.205089745235;15953.920230398773;16113.436029738903;16140.919295403448;16386.75419868679;32931.34137317193;33148;34129.65870341265;34523.96428107161;35338;40518.59481405148;41784.79107604564;42626;43132.56867431285;43606.345904812086;7329.706811727471;7564.848703025798;7644.273793989562;7683.346915512244;7713.382929365749;10443.321184123008;11933.522659093886;12119;12314.13801033919;12393.938030309791;7861.371090312647;10132.44271565071;10224.539895704562;10266.332688375232;10487.79024419492;10202.540885660015;10229.130523905551;10278.691639250834;10300.948495257475;10440.060394564525;3225.8064516129107;4965.354503914468;7791.571463569331;10457.633982810565;10773.559352527238;7639.694412223449;7656.310932016146;7698.499597526143;7748.883766743391;7758.4181186410115;8906.73279801607;10763.569457221623;10919.83620245681;10938.835917461085;11075.612353567587 22:32:29 INFO - PROCESS | 4036 | |3;mootools.html;1353.1001883747297;1472.0505274098207;1502.9323680434377;1673.4059408909836;1814.5826459914229;7190.8561828763395;7363.705451781929;7797.493162944412;7954.125046244909;7965.322947549465;7877;7892.447528672995;7899.92100078999;7914.3272821810215;7928.3657307415415;2017.1830408684507;2070.834333253336;2314.2131675230416;2360.1031607989025;2360.4688944987324;2338.8012018978407;2392.557376885282;2395.6286775549816;2399.400149962509;2409.5301416223842;2315.120254303371;2344.824138189634;2346.835721499496;2348.6124789409814;2360.24472168906;2309.734380546242;2318.5015221727326;2327.848689835164;2340.7659234076455;2348.4833336665906;2336.7663233676667;2340.6020976434047;2345.026813872241;2350.471143992605;2391.4858305464236;8104.1085480597085;8109.675612975474;8128.1465446127895;8131.878021829618;8198.139195384458;4822.132016237076;4982.57648099912;4983.526564976321;4991.376077990251;4995.650304478688;3215.469447541153;3233.1270556949494;3251.821149836758;3254.23525471514;3279.2949515854207;982.3761911186376;1008.9445080520568;1071.1216802222182;1080.4543705428787;1101.9228653994223;11298.209125361229;11477.253978491455;11522.135839812048;11542.249753765978;11552.6534203974;4410.470743510735;4574.542545745466;4689.320048593003;4695.295705644181;4759.095771803415;8903.55482225886;8947.642094316285;8949.686760963335;8961.641534338683;8969.37214394986;5041.773120209599;5049.2930989660745;5055.368078990126;5056.393232812086;5058.215976523645;4558.430196225472;4597.080583883237;4598.977005114953;4646.395968524138;4651.837185698484;3387.1532116970757;3433.5879694436326;3464.0993341731332;3592.2456284180616;3642.7814331140216;1071.3036526257995;1088.374184843718;1090.2804149261608;1093.9781204376027;1098.7198264442675;1017;1023.4013102335217;1024.0374048394635;1121.6242558742913;1319.3864852843474;7470.626468676544;7483.513571617827;7510.887336689954;7512.812179695551;7520.774376768706;1094.7755710079414;1118.7091356247433;1130.0733398613058;1131.7365269461077;1157.085902137319;5958.880822383528;6053.939460605426;6065.5450841187085;6076.574639775262;6084;9669;10255.743606409751;10398.844017339747;10407;10407.375557466576;10140.847887281696;10181.818181818182;10285.43430111351;10301.587936482456;10302.948485257526;7622.847543049108;7701.191374905667;7716.575588342583;7876.881846772303;7885.329746971572;7295.562266264041;7392.186859445349;7435.182129965808;7440.479166458296;7448.73929412468;8485.660573577235;8526.104759000216;8636.481811091355;8720.651173953225;8744.606492707717;8708.608112635073;8842.734717958472;9090.454572725657;9094.909050909406;9155.77110572241;7613.352865006536;7719.6140192989005;7727.381809455343;7736.226377362219;7738.651760670671;6966.3730264276455;7126.750563730245;7301.379382752525;7511.436642251962;7513.323800857949;7284.963575182091;7322.3775979042375;7335.486515944046;7372.447066469929;7474.701011959461;7362.6318684066655;7388.1503627083575;7445.367143792621;7496.362809161064;7556.811079723051;7396.0754905636795;7429.33136017761;7460.29127232912;7490.176080631018;7507.286807753255;6752.392284694204;6799.660016999229;6805.489588280998;6809.625470599165;6816.556923799937;6742.561733487308;6799.898001529882;6823.147106611674;6834.384905358542;6834.829129271808 22:32:29 INFO - PROCESS | 4036 | |4;prototype.html;335.86061784359487;337.80744975364024;338.45677687311866;340.8994346667733;346.19855035592616;5745.396733342996;5770.04794208955;5777.682227477487;5782.3639399666;5789.884202315951;5726.770929162839;5728.198052272674;5735.483806457418;5737.2541569596;5756.079027355624;4481.932771008429;4493.573110554508;4494.07871386365;4494.4831344395325;4496.033352829141;4406.735595864258;4484.439445069366;4492.146492166478;4495.910081798362;4498.730076195422;4424.402705634747;4439.356293337464;4439.622632076277;4448.199324121657;4460.018795864905;4237.915241695179;4329.805158767832;4440.333949907524;4445.68880178386;4451.243288640939;3871.1483473636035;3895.474110995008;3920.5099362579676;3923.4114882767526;3941.960580394188;5381.354237491487;5437.13005919055;5478.58910581708;5480.780768769245;5486.31421072366;4887.218045112801;5003.249512573107;5065.569426598743;5153.896922061538;5185.22221666753;6008.24896887889;6031.09533569968;6045.818625441244;6059.6364218147055;6060.515158787286;4307.203167414007;4310.849120280806;4311.094670119247;4348.412964249817;4366.803493842753;6179.443850053472;6339.017452294902;6340.904886426707;6352.205974253218;6373.3945275198785;4464.866054018385;4466.731996080181;4474.798634061475;4476.283794592915;4480.977595112004;4537.115262523842;4537.38745269391;4540.364348991144;4541.772911354486;4542.954570454253;5157.767900444489;5166.147585648401;5168.751593057033;5170.689758614495;5171.224316352577;6040.124181993587;6117.847053823601;6152.415520525543;6152.661603611844;6153.907691384633;1578.48699172767;1591.2282542966652;1597.1295643873884;1601.9439319623991;1603.350642989591;1089.2701889733896;1095.2388090277182;1100.1089117814595;1114.3091283404342;1119.1662211652372;5741.942580574224;5757.625754325955;5761.942380576224;5763.942360576424;5771.105478650816;6232.906506402408;6257.749690012349;6269.435750782361;6279.780207692709;6284.183056202664;5770.624909380961;5771.711414429262;5772.134179873053;5774.566907481955;5779.88440231193;3296.3901678189613;3381.120908563791;3387.2886693794085;3388.2715216228135;3389.9661003390142;6528.151340325728;6529.510286728514;6534.150560427114;6540.345965403517;6540.771073012517;6251.499880009588;6428.939225027912;6432.839179020469;6433.549651524442;6435.7747478838955;6371.808845734636;6528.053432252297;6583.308752581006;6590.604563726191;6611.603303801788;6309.810705678837;6343.873122537431;6347.460465860454;6347.587406818542;6352.650604216812;6101.694915254308;6280.1207830902795;6302.873942521032;6303.842403939755;6310.968445157745;6636.469082473487;6642.13652225227;6644.534882558174;6645.169353830771;6652.501062420241;4340.587644173798;4366.716163449366;4372.256716358163;4377.693561450796;4380;6377.936220637735;6394.584352017104;6413.935860641333;6439.613623182624;6459.61242325462;6052.6973651316375;6223;6227.626342419469;6228.283747369111;6243.063540468966;6190.350013248544;6191.659458729813;6191.81424557264;6192.81421557354;6278.7488500461295;6108.8778224436155;6109.938900611115;6110.297315808739;6112.266528016667;6119.724612392542;6066.484348830399;6267.185265915402;6267.592606480564;6272.686365681607;6279.372062793684;6113.969430152821;6116.908246376397;6122.2959359674205;6122.938770612237;6123.112148738319 22:32:29 INFO - PROCESS | 4036 | |5;yui.html;639.466045851714;659.1233659233219;734.7758933525276;741.3920585120204;742.3430264216167;13973.161610303388;14206.857931420684;14230.786538201935;14283.428662853486;14289.857101428983;14686;15128.924355378234;15137.924310378432;15151.318190681419;15156.696866062672;683.5351960666744;690;808.1110778144039;828.693383448125;829.3696790439279;777.327611615951;781.9178986206451;783.4163548156631;784.2667106255669;786.5713186313444;872.6160489384682;873.2359185712502;873.6461732998146;875.2472873328932;875.5665945357057;698.580851489105;703.3423748794893;825.0264687668549;856.8157846063064;873.2577309287055;642.3576423576424;643.1221382812428;644.548815828917;645.9192600924885;647.491719000587;12782.169159004636;12789.232646041268;12884.291363974977;12956.157849739831;12964.416601252966;12079.57721479744;12400.8139877901;12561.497540098386;12831;13054.086213965027;9957.302988790787;9977.25170612207;10136.149814522038;10251.436171010591;10510.159187265;3311.3542859142476;3381.9830900845336;3397.065806903097;3399.269157131204;3453.620101788801;53605.1959220612;53813.19280210761;54042.45957540453;54074.72962635162;54090;9380.296477764196;9471.242300615933;9613.855792163124;9796.216302695768;9853.704388868346;17258.741118883227;17263.482095537154;17335.393261235797;17362.39231626912;17380.130993450275;7335.88996165058;7410.740624078131;7464.178940316561;7494.100707915085;7642.312191902755;4196.307609244441;4270.807813648394;4323.156984388014;4359.956400436018;4361.105973275471;3226.7741258111705;3230.2570408806105;3236.3527294541186;3236.660150684191;3248.9675103249137;557.3395526301346;564.176302598203;574.1645905207912;575.7524264566193;578.9507891829157;620.9316975132732;631.9810405687837;634.7365843175123;638.9361063893573;644.3009334871623;7848.607569621496;8092.554909480035;8237.423380363436;8291.304823579821;8310.168983101763;514;523.5131327865046;524.048851334826;547.4771593128553;614.2046050364788;3427.8628854846024;3521.5421995140982;3563.625819288989;3730.813459327023;3899.512560929884;54313.45686543163;54769.72615136899;57526.424735752946;59167.70416147978;59215.70392148098;46623;46786.76606617013;46893.29660055102;49038.509614904106;49607.50392496101;42687.99999999938;42919.57080429218;43134.13731725348;43197;43237.35143972843;8292.61231762879;8445.915540844513;8625.137486251324;8660.437071590326;8682.131786821268;35594.46608300826;36504.26991460209;36727.449088264235;38251;38321.4251786229;45866.770666146454;46217.306740399596;46598.53401465942;46739;47599.76200119116;10071.597136114766;10080.445575493419;10192.592296308065;10421.739456513647;10547.57809687604;11246.775064498828;11466.312021278416;11538.961493465293;11552;11851.881481185077;9892.901070989486;10719.517621706886;11034.889651103385;11118.054965328038;11258.718532036437;10480.371177729055;10674.46627668629;10713.303635263683;10790.67627971162;10979.066779323528;10514.211434142317;10532.157427405637;10699.625513107005;10804;10880.075193608633;8625.482471051757;8629.913700862911;8700.60847261862;8908.376413650982;9008.459492430475;8583.527905964982;8766.824663506823;8821.2060914518;9105.135012173832;9149.908500914906 22:32:29 INFO - PROCESS | 4036 | __end_tp_report 22:32:29 INFO - PROCESS | 4036 | __start_cc_report 22:32:29 INFO - PROCESS | 4036 | _x_x_mozilla_cycle_collect,1537 22:32:29 INFO - PROCESS | 4036 | __end_cc_report 22:32:29 INFO - PROCESS | 4036 | __startTimestamp1454653949812__endTimestamp 22:32:29 INFO - PROCESS | 4036 | 22:32:29 INFO - PROCESS | 4036 | ------- Summary: start ------- 22:32:29 INFO - PROCESS | 4036 | Number of tests: 6 22:32:29 INFO - PROCESS | 4036 | 22:32:29 INFO - PROCESS | 4036 | [#0] dojo.html Cycles:165 Average:5203.43 Median:5453.92 stddev:574.50 (10.5%) stddev-sans-first:553.56 22:32:29 INFO - PROCESS | 4036 | Values: 3165.1 3192.2 3225.8 3227.2 3251.2 5090.2 5136.5 5148.2 5198.8 5243.3 5171.2 5206.7 5228.7 5256.8 5284.2 4704.9 4716.7 4727.9 4743.3 4882.7 4822.7 4837.1 4850.5 4859.4 4873.1 4740.2 4760.9 4818.0 4820.3 4879.8 4774.0 4779.8 4784.0 4802.7 4814.5 4726.0 4731.3 4735.1 4746.0 4757.5 5047.0 5084.3 5084.4 5154.1 5204.5 5592.2 5617.0 5618.6 5624.7 5631.5 5655.3 5661.6 5674.1 5676.3 5684.4 5175.4 5249.4 5250.2 5250.6 5344.2 5721.2 5730.8 5736.2 5740.1 5785.8 5522.2 5530.5 5531.0 5531.5 5534.6 5616.3 5660.0 5706.4 5707.2 5748.1 5457.6 5498.2 5498.9 5503.7 5504.1 5461.3 5507.9 5509.1 5511.4 5543.0 4184.8 4230.1 4266.4 4276.8 4287.9 3784.4 3787.6 3789.1 3819.7 3833.4 5178.6 5180.5 5192.7 5194.4 5250.4 5517.1 5598.4 5600.6 5602.5 5616.5 5167.0 5181.8 5184.8 5186.0 5194.1 4755.9 4759.6 4760.0 4763.6 4799.0 5749.4 5784.8 5813.1 5820.0 5835.4 5572.6 5573.7 5574.8 5577.0 5605.3 5756.9 5775.9 5778.7 5781.5 5782.2 5546.8 5564.6 5629.0 5632.4 5640.3 5557.2 5593.8 5594.1 5596.9 5600.2 5467.8 5468.7 5469.0 5471.3 5487.9 5447.2 5452.5 5453.9 5470.9 5508.7 5453.1 5460.0 5470.0 5470.4 5509.3 5567.5 5574.6 5575.7 5576.4 5578.1 5359.9 5426.4 5430.8 5441.8 5501.7 22:32:29 INFO - PROCESS | 4036 | 22:32:29 INFO - PROCESS | 4036 | [#1] ext.html Cycles:180 Average:47058.85 Median:36928.13 stddev:81028.06 (219.4%) stddev-sans-first:81180.06 22:32:29 INFO - PROCESS | 4036 | Values: 531.1 556.9 561.4 562.6 607.5 28935.3 29432.4 36612.8 37243.4 37293.4 40413.4 40428.6 40680.0 40703.8 40782.6 8430.1 8579.1 8631.4 8637.1 8637.4 8386.0 8552.8 8569.0 8572.3 8573.0 8708.4 8751.0 8775.5 8778.3 8779.5 8682.6 8731.2 8737.5 8741.8 8753.0 8687.4 8803.7 8819.3 8819.3 8819.6 40506.6 41016.4 41062.8 41068.8 41107.4 3340.7 3500.6 3544.4 3754.5 3880.6 28838.1 30669.5 31159.7 31233.4 31508.5 3350.1 3769.2 3912.6 3978.2 4001.6 282719.0 284470.0 284872.6 285463.0 285781.0 52978.5 61961.0 62146.0 62434.4 62502.4 49113.0 49116.0 49141.3 49281.5 66323.0 14517.9 14815.2 14948.4 14957.9 14958.0 11223.0 11291.2 11323.7 11324.6 11387.3 16553.9 16748.2 19637.6 20209.2 20757.4 7496.3 7638.7 7666.2 7770.0 7836.0 876.3 907.4 961.6 1007.6 1053.8 29478.7 29962.4 30159.8 30560.7 30665.4 1036.3 1043.4 1047.2 1083.1 1171.6 15451.5 15804.2 16003.1 16092.5 16730.7 385720.0 390487.0 391324.0 393154.0 393629.0 55236.4 55910.7 55936.7 55984.2 56091.2 1268.8 1270.7 1277.4 1284.6 1294.9 29946.6 31288.3 31347.7 31589.8 31731.0 46305.5 46792.0 46817.3 46914.0 46936.0 225035.0 227363.0 227504.0 228142.0 228375.0 28342.0 28577.4 31882.5 33032.2 33433.3 38967.6 39460.2 46865.8 48357.8 48844.3 34477.8 34616.8 34721.0 34970.3 35445.6 35074.3 35272.3 35416.5 35458.0 35594.0 35271.3 35884.5 35970.6 37515.8 38816.4 31510.5 35784.5 35954.8 36001.0 37914.4 26054.9 26591.5 26682.5 27139.7 28767.6 22:32:29 INFO - PROCESS | 4036 | 22:32:29 INFO - PROCESS | 4036 | [#2] jquery.html Cycles:180 Average:24273.55 Median:4106.24 stddev:72681.80 (1770.0%) stddev-sans-first:72863.50 22:32:29 INFO - PROCESS | 4036 | Values: 353.7 355.7 359.5 360.7 363.9 13573.3 13785.9 16263.7 17411.4 18297.4 15794.8 15896.4 16376.9 16379.3 16393.6 4667.0 4819.2 4838.8 4876.4 4878.6 3735.2 3866.9 4845.5 4882.2 5159.9 5247.3 5248.0 5249.2 5282.9 5312.8 5426.9 5685.8 5866.0 5873.6 5882.6 4957.3 5128.8 5151.0 5162.4 5164.1 11502.8 11673.8 11745.5 14122.5 20095.6 2045.6 2067.7 2089.1 2135.7 2178.7 9095.2 9327.1 9360.6 9378.1 9585.9 1829.4 1864.0 1870.8 1907.3 1913.1 57138.0 58618.1 60095.4 60192.8 61010.0 9552.4 9617.7 9677.8 9696.0 9777.7 12397.8 12505.5 12558.2 12559.6 12593.0 6912.2 7036.9 7037.8 7074.0 7105.4 6825.2 6851.5 6856.3 6877.9 6917.2 4088.9 4123.6 4145.2 4208.9 4429.3 1578.9 1639.5 1639.9 1671.5 1697.8 447.7 459.9 930.7 1009.5 1025.7 10398.5 10567.7 10782.2 10791.6 10886.3 457.4 462.7 465.5 484.9 893.0 8757.6 9526.3 9571.5 9970.6 10039.3 351897.0 355291.0 357425.0 547303.0 549343.0 72713.6 73810.6 73833.0 76757.0 77104.6 1173.7 1174.0 1224.1 1228.0 1246.6 15898.2 15953.9 16113.4 16140.9 16386.8 32931.3 33148.0 34129.7 34524.0 35338.0 40518.6 41784.8 42626.0 43132.6 43606.3 7329.7 7564.8 7644.3 7683.3 7713.4 10443.3 11933.5 12119.0 12314.1 12393.9 7861.4 10132.4 10224.5 10266.3 10487.8 10202.5 10229.1 10278.7 10300.9 10440.1 3225.8 4965.4 7791.6 10457.6 10773.6 7639.7 7656.3 7698.5 7748.9 7758.4 8906.7 10763.6 10919.8 10938.8 11075.6 22:32:29 INFO - PROCESS | 4036 | 22:32:29 INFO - PROCESS | 4036 | [#3] mootools.html Cycles:180 Average:5703.23 Median:5055.88 stddev:2993.71 (59.2%) stddev-sans-first:2984.25 22:32:29 INFO - PROCESS | 4036 | Values: 1353.1 1472.1 1502.9 1673.4 1814.6 7190.9 7363.7 7797.5 7954.1 7965.3 7877.0 7892.4 7899.9 7914.3 7928.4 2017.2 2070.8 2314.2 2360.1 2360.5 2338.8 2392.6 2395.6 2399.4 2409.5 2315.1 2344.8 2346.8 2348.6 2360.2 2309.7 2318.5 2327.8 2340.8 2348.5 2336.8 2340.6 2345.0 2350.5 2391.5 8104.1 8109.7 8128.1 8131.9 8198.1 4822.1 4982.6 4983.5 4991.4 4995.7 3215.5 3233.1 3251.8 3254.2 3279.3 982.4 1008.9 1071.1 1080.5 1101.9 11298.2 11477.3 11522.1 11542.2 11552.7 4410.5 4574.5 4689.3 4695.3 4759.1 8903.6 8947.6 8949.7 8961.6 8969.4 5041.8 5049.3 5055.4 5056.4 5058.2 4558.4 4597.1 4599.0 4646.4 4651.8 3387.2 3433.6 3464.1 3592.2 3642.8 1071.3 1088.4 1090.3 1094.0 1098.7 1017.0 1023.4 1024.0 1121.6 1319.4 7470.6 7483.5 7510.9 7512.8 7520.8 1094.8 1118.7 1130.1 1131.7 1157.1 5958.9 6053.9 6065.5 6076.6 6084.0 9669.0 10255.7 10398.8 10407.0 10407.4 10140.8 10181.8 10285.4 10301.6 10302.9 7622.8 7701.2 7716.6 7876.9 7885.3 7295.6 7392.2 7435.2 7440.5 7448.7 8485.7 8526.1 8636.5 8720.7 8744.6 8708.6 8842.7 9090.5 9094.9 9155.8 7613.4 7719.6 7727.4 7736.2 7738.7 6966.4 7126.8 7301.4 7511.4 7513.3 7285.0 7322.4 7335.5 7372.4 7474.7 7362.6 7388.2 7445.4 7496.4 7556.8 7396.1 7429.3 7460.3 7490.2 7507.3 6752.4 6799.7 6805.5 6809.6 6816.6 6742.6 6799.9 6823.1 6834.4 6834.8 22:32:29 INFO - PROCESS | 4036 | 22:32:29 INFO - PROCESS | 4036 | [#4] prototype.html Cycles:180 Average:5146.70 Median:5770.34 stddev:1532.65 (26.6%) stddev-sans-first:1493.81 22:32:29 INFO - PROCESS | 4036 | Values: 335.9 337.8 338.5 340.9 346.2 5745.4 5770.0 5777.7 5782.4 5789.9 5726.8 5728.2 5735.5 5737.3 5756.1 4481.9 4493.6 4494.1 4494.5 4496.0 4406.7 4484.4 4492.1 4495.9 4498.7 4424.4 4439.4 4439.6 4448.2 4460.0 4237.9 4329.8 4440.3 4445.7 4451.2 3871.1 3895.5 3920.5 3923.4 3942.0 5381.4 5437.1 5478.6 5480.8 5486.3 4887.2 5003.2 5065.6 5153.9 5185.2 6008.2 6031.1 6045.8 6059.6 6060.5 4307.2 4310.8 4311.1 4348.4 4366.8 6179.4 6339.0 6340.9 6352.2 6373.4 4464.9 4466.7 4474.8 4476.3 4481.0 4537.1 4537.4 4540.4 4541.8 4543.0 5157.8 5166.1 5168.8 5170.7 5171.2 6040.1 6117.8 6152.4 6152.7 6153.9 1578.5 1591.2 1597.1 1601.9 1603.4 1089.3 1095.2 1100.1 1114.3 1119.2 5741.9 5757.6 5761.9 5763.9 5771.1 6232.9 6257.7 6269.4 6279.8 6284.2 5770.6 5771.7 5772.1 5774.6 5779.9 3296.4 3381.1 3387.3 3388.3 3390.0 6528.2 6529.5 6534.2 6540.3 6540.8 6251.5 6428.9 6432.8 6433.5 6435.8 6371.8 6528.1 6583.3 6590.6 6611.6 6309.8 6343.9 6347.5 6347.6 6352.7 6101.7 6280.1 6302.9 6303.8 6311.0 6636.5 6642.1 6644.5 6645.2 6652.5 4340.6 4366.7 4372.3 4377.7 4380.0 6377.9 6394.6 6413.9 6439.6 6459.6 6052.7 6223.0 6227.6 6228.3 6243.1 6190.4 6191.7 6191.8 6192.8 6278.7 6108.9 6109.9 6110.3 6112.3 6119.7 6066.5 6267.2 6267.6 6272.7 6279.4 6114.0 6116.9 6122.3 6122.9 6123.1 22:32:29 INFO - PROCESS | 4036 | 22:32:29 INFO - PROCESS | 4036 | [#5] yui.html Cycles:180 Average:13721.10 Median:49323.01 stddev:16128.06 (32.7%) stddev-sans-first:16143.39 22:32:29 INFO - PROCESS | 4036 | Values: 639.5 659.1 734.8 741.4 742.3 13973.2 14206.9 14230.8 14283.4 14289.9 14686.0 15128.9 15137.9 15151.3 15156.7 683.5 690.0 808.1 828.7 829.4 777.3 781.9 783.4 784.3 786.6 872.6 873.2 873.6 875.2 875.6 698.6 703.3 825.0 856.8 873.3 642.4 643.1 644.5 645.9 647.5 12782.2 12789.2 12884.3 12956.2 12964.4 12079.6 12400.8 12561.5 12831.0 13054.1 9957.3 9977.3 10136.1 10251.4 10510.2 3311.4 3382.0 3397.1 3399.3 3453.6 53605.2 53813.2 54042.5 54074.7 54090.0 9380.3 9471.2 9613.9 9796.2 9853.7 17258.7 17263.5 17335.4 17362.4 17380.1 7335.9 7410.7 7464.2 7494.1 7642.3 4196.3 4270.8 4323.2 4360.0 4361.1 3226.8 3230.3 3236.4 3236.7 3249.0 557.3 564.2 574.2 575.8 579.0 620.9 632.0 634.7 638.9 644.3 7848.6 8092.6 8237.4 8291.3 8310.2 514.0 523.5 524.0 547.5 614.2 3427.9 3521.5 3563.6 3730.8 3899.5 54313.5 54769.7 57526.4 59167.7 59215.7 46623.0 46786.8 46893.3 49038.5 49607.5 42688.0 42919.6 43134.1 43197.0 43237.4 8292.6 8445.9 8625.1 8660.4 8682.1 35594.5 36504.3 36727.4 38251.0 38321.4 45866.8 46217.3 46598.5 46739.0 47599.8 10071.6 10080.4 10192.6 10421.7 10547.6 11246.8 11466.3 11539.0 11552.0 11851.9 9892.9 10719.5 11034.9 11118.1 11258.7 10480.4 10674.5 10713.3 10790.7 10979.1 10514.2 10532.2 10699.6 10804.0 10880.1 8625.5 8629.9 8700.6 8908.4 9008.5 8583.5 8766.8 8821.2 9105.1 9149.9 22:32:29 INFO - PROCESS | 4036 | -------- Summary: end -------- 22:32:29 INFO - PROCESS | 4036 | 22:32:30 INFO - TEST-INFO | 4036: exit 0 22:32:30 INFO - TEST-OK | dromaeo_css | took 1113714ms 22:32:30 INFO - TEST-START | kraken 22:32:30 INFO - operating with platform_type : linux_ 22:32:30 INFO - Initialising browser for kraken test... 22:32:30 INFO - TEST-INFO | started process 4226 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmFMQiE/profile http://localhost:52961/getInfo.html) 22:32:30 INFO - PROCESS | 4226 | JavaScript warning: resource://gre/modules/AddonManager.jsm, line 692: Proxy.create and Proxy.createFunction are deprecated, use new Proxy instead 22:32:34 INFO - PROCESS | 4226 | __metrics Screen width/height:1600/1200 22:32:34 INFO - PROCESS | 4226 | colorDepth:24 22:32:34 INFO - PROCESS | 4226 | Browser inner width/height: 1024/697 22:32:34 INFO - PROCESS | 4226 | __metrics 22:32:34 INFO - PROCESS | 4226 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:32:35 INFO - TEST-INFO | 4226: exit 0 22:32:35 INFO - Browser initialized. 22:32:35 INFO - Running cycle 1/1 for kraken test... 22:32:35 INFO - TEST-INFO | started process 4307 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmFMQiE/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:32:47 INFO - PROCESS | 4307 | RSS: Main: 149782528 22:32:47 INFO - PROCESS | 4307 | 22:32:49 INFO - PROCESS | 4307 | Cycle 1(1): loaded http://localhost:52961/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52961/tests/kraken/driver.html?testName=audio-beat-detection) 22:32:50 INFO - PROCESS | 4307 | RSS: Main: 193425408 22:32:50 INFO - PROCESS | 4307 | 22:32:52 INFO - PROCESS | 4307 | Cycle 1(1): loaded http://localhost:52961/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52961/tests/kraken/driver.html?testName=audio-dft) 22:32:53 INFO - PROCESS | 4307 | RSS: Main: 181166080 22:32:53 INFO - PROCESS | 4307 | 22:32:56 INFO - PROCESS | 4307 | Cycle 1(1): loaded http://localhost:52961/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52961/tests/kraken/driver.html?testName=audio-fft) 22:32:56 INFO - PROCESS | 4307 | RSS: Main: 166510592 22:32:56 INFO - PROCESS | 4307 | 22:32:58 INFO - PROCESS | 4307 | Cycle 1(1): loaded http://localhost:52961/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52961/tests/kraken/driver.html?testName=audio-oscillator) 22:32:59 INFO - PROCESS | 4307 | RSS: Main: 168685568 22:32:59 INFO - PROCESS | 4307 | 22:33:01 INFO - PROCESS | 4307 | Cycle 1(1): loaded http://localhost:52961/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52961/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:33:02 INFO - PROCESS | 4307 | RSS: Main: 170225664 22:33:02 INFO - PROCESS | 4307 | 22:33:05 INFO - PROCESS | 4307 | Cycle 1(1): loaded http://localhost:52961/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52961/tests/kraken/driver.html?testName=imaging-darkroom) 22:33:05 INFO - PROCESS | 4307 | RSS: Main: 169709568 22:33:05 INFO - PROCESS | 4307 | 22:33:09 INFO - PROCESS | 4307 | Cycle 1(1): loaded http://localhost:52961/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52961/tests/kraken/driver.html?testName=imaging-desaturate) 22:33:09 INFO - PROCESS | 4307 | RSS: Main: 169734144 22:33:09 INFO - PROCESS | 4307 | 22:33:12 INFO - PROCESS | 4307 | Cycle 1(1): loaded http://localhost:52961/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52961/tests/kraken/driver.html?testName=json-parse-financial) 22:33:13 INFO - PROCESS | 4307 | RSS: Main: 171274240 22:33:13 INFO - PROCESS | 4307 | 22:33:14 INFO - PROCESS | 4307 | Cycle 1(1): loaded http://localhost:52961/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52961/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:33:15 INFO - PROCESS | 4307 | RSS: Main: 181174272 22:33:15 INFO - PROCESS | 4307 | 22:33:17 INFO - PROCESS | 4307 | Cycle 1(1): loaded http://localhost:52961/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52961/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:33:17 INFO - PROCESS | 4307 | RSS: Main: 178253824 22:33:17 INFO - PROCESS | 4307 | 22:33:19 INFO - PROCESS | 4307 | Cycle 1(1): loaded http://localhost:52961/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52961/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:33:20 INFO - PROCESS | 4307 | RSS: Main: 192413696 22:33:20 INFO - PROCESS | 4307 | 22:33:22 INFO - PROCESS | 4307 | Cycle 1(1): loaded http://localhost:52961/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52961/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:33:23 INFO - PROCESS | 4307 | RSS: Main: 197611520 22:33:23 INFO - PROCESS | 4307 | 22:33:25 INFO - PROCESS | 4307 | Cycle 1(1): loaded http://localhost:52961/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52961/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:33:26 INFO - PROCESS | 4307 | RSS: Main: 192573440 22:33:26 INFO - PROCESS | 4307 | 22:33:28 INFO - PROCESS | 4307 | Cycle 1(1): loaded http://localhost:52961/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52961/tests/kraken/driver.html?testName=ai-astar) 22:33:28 INFO - PROCESS | 4307 | RSS: Main: 254005248 22:33:28 INFO - PROCESS | 4307 | 22:33:28 INFO - PROCESS | 4307 | __start_tp_report 22:33:28 INFO - PROCESS | 4307 | _x_x_mozilla_page_load 22:33:28 INFO - PROCESS | 4307 | _x_x_mozilla_page_load_details 22:33:28 INFO - PROCESS | 4307 | |i|pagename|runs| 22:33:28 INFO - PROCESS | 4307 | |0;ai-astar;109;112;106;111;111;111;99;110;110;110 22:33:28 INFO - PROCESS | 4307 | |1;audio-beat-detection;151;127;149;164;129;151;146;131;168;127 22:33:28 INFO - PROCESS | 4307 | |2;audio-dft;161;162;162;161;160;160;161;164;162;161 22:33:28 INFO - PROCESS | 4307 | |3;audio-fft;81;73;95;93;75;73;75;109;93;76 22:33:28 INFO - PROCESS | 4307 | |4;audio-oscillator;95;95;148;95;95;96;140;95;95;143 22:33:28 INFO - PROCESS | 4307 | |5;imaging-gaussian-blur;119;115;114;115;114;115;115;115;114;114 22:33:28 INFO - PROCESS | 4307 | |6;imaging-darkroom;147;146;146;147;145;146;145;146;146;145 22:33:28 INFO - PROCESS | 4307 | |7;imaging-desaturate;96;96;96;97;96;96;96;96;96;95 22:33:28 INFO - PROCESS | 4307 | |8;json-parse-financial;56;57;57;55;55;55;57;65;53;53 22:33:28 INFO - PROCESS | 4307 | |9;json-stringify-tinderbox;66;67;68;67;67;68;67;67;67;68 22:33:28 INFO - PROCESS | 4307 | |10;stanford-crypto-aes;92;86;86;85;85;86;87;87;87;89 22:33:28 INFO - PROCESS | 4307 | |11;stanford-crypto-ccm;117;118;121;115;126;123;124;124;114;119 22:33:28 INFO - PROCESS | 4307 | |12;stanford-crypto-pbkdf2;152;140;150;151;150;140;162;150;151;161 22:33:28 INFO - PROCESS | 4307 | |13;stanford-crypto-sha256-iterative;68;70;70;68;68;71;69;69;68;66 22:33:28 INFO - PROCESS | 4307 | __end_tp_report 22:33:28 INFO - PROCESS | 4307 | __start_cc_report 22:33:28 INFO - PROCESS | 4307 | _x_x_mozilla_cycle_collect,969 22:33:28 INFO - PROCESS | 4307 | __end_cc_report 22:33:28 INFO - PROCESS | 4307 | __startTimestamp1454654008482__endTimestamp 22:33:28 INFO - PROCESS | 4307 | 22:33:28 INFO - PROCESS | 4307 | ------- Summary: start ------- 22:33:28 INFO - PROCESS | 4307 | Number of tests: 14 22:33:28 INFO - PROCESS | 4307 | 22:33:28 INFO - PROCESS | 4307 | [#0] ai-astar Cycles:10 Average:108.90 Median:111.00 stddev:3.84 (3.5%) stddev-sans-first:4.08 22:33:28 INFO - PROCESS | 4307 | Values: 109.0 112.0 106.0 111.0 111.0 111.0 99.0 110.0 110.0 110.0 22:33:28 INFO - PROCESS | 4307 | 22:33:28 INFO - PROCESS | 4307 | [#1] audio-beat-detection Cycles:10 Average:144.30 Median:150.00 stddev:15.18 (10.1%) stddev-sans-first:15.91 22:33:28 INFO - PROCESS | 4307 | Values: 151.0 127.0 149.0 164.0 129.0 151.0 146.0 131.0 168.0 127.0 22:33:28 INFO - PROCESS | 4307 | 22:33:28 INFO - PROCESS | 4307 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.17 (0.7%) stddev-sans-first:1.24 22:33:28 INFO - PROCESS | 4307 | Values: 161.0 162.0 162.0 161.0 160.0 160.0 161.0 164.0 162.0 161.0 22:33:28 INFO - PROCESS | 4307 | 22:33:28 INFO - PROCESS | 4307 | [#3] audio-fft Cycles:10 Average:84.30 Median:78.50 stddev:12.40 (15.8%) stddev-sans-first:13.10 22:33:28 INFO - PROCESS | 4307 | Values: 81.0 73.0 95.0 93.0 75.0 73.0 75.0 109.0 93.0 76.0 22:33:28 INFO - PROCESS | 4307 | 22:33:28 INFO - PROCESS | 4307 | [#4] audio-oscillator Cycles:10 Average:109.70 Median:95.00 stddev:23.52 (24.8%) stddev-sans-first:24.34 22:33:28 INFO - PROCESS | 4307 | Values: 95.0 95.0 148.0 95.0 95.0 96.0 140.0 95.0 95.0 143.0 22:33:28 INFO - PROCESS | 4307 | 22:33:28 INFO - PROCESS | 4307 | [#5] imaging-gaussian-blur Cycles:10 Average:115.00 Median:115.00 stddev:1.49 (1.3%) stddev-sans-first:0.53 22:33:28 INFO - PROCESS | 4307 | Values: 119.0 115.0 114.0 115.0 114.0 115.0 115.0 115.0 114.0 114.0 22:33:28 INFO - PROCESS | 4307 | 22:33:28 INFO - PROCESS | 4307 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 22:33:28 INFO - PROCESS | 4307 | Values: 147.0 146.0 146.0 147.0 145.0 146.0 145.0 146.0 146.0 145.0 22:33:28 INFO - PROCESS | 4307 | 22:33:28 INFO - PROCESS | 4307 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 22:33:28 INFO - PROCESS | 4307 | Values: 96.0 96.0 96.0 97.0 96.0 96.0 96.0 96.0 96.0 95.0 22:33:28 INFO - PROCESS | 4307 | 22:33:28 INFO - PROCESS | 4307 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:56.50 stddev:3.40 (6.0%) stddev-sans-first:3.61 22:33:28 INFO - PROCESS | 4307 | Values: 56.0 57.0 57.0 55.0 55.0 55.0 57.0 65.0 53.0 53.0 22:33:28 INFO - PROCESS | 4307 | 22:33:28 INFO - PROCESS | 4307 | [#9] json-stringify-tinderbox Cycles:10 Average:67.20 Median:67.00 stddev:0.63 (0.9%) stddev-sans-first:0.50 22:33:28 INFO - PROCESS | 4307 | Values: 66.0 67.0 68.0 67.0 67.0 68.0 67.0 67.0 67.0 68.0 22:33:28 INFO - PROCESS | 4307 | 22:33:28 INFO - PROCESS | 4307 | [#10] stanford-crypto-aes Cycles:10 Average:87.00 Median:87.00 stddev:2.11 (2.4%) stddev-sans-first:1.24 22:33:28 INFO - PROCESS | 4307 | Values: 92.0 86.0 86.0 85.0 85.0 86.0 87.0 87.0 87.0 89.0 22:33:28 INFO - PROCESS | 4307 | 22:33:28 INFO - PROCESS | 4307 | [#11] stanford-crypto-ccm Cycles:10 Average:120.10 Median:122.00 stddev:4.12 (3.4%) stddev-sans-first:4.22 22:33:28 INFO - PROCESS | 4307 | Values: 117.0 118.0 121.0 115.0 126.0 123.0 124.0 124.0 114.0 119.0 22:33:28 INFO - PROCESS | 4307 | 22:33:28 INFO - PROCESS | 4307 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.70 Median:151.00 stddev:7.20 (4.8%) stddev-sans-first:7.62 22:33:28 INFO - PROCESS | 4307 | Values: 152.0 140.0 150.0 151.0 150.0 140.0 162.0 150.0 151.0 161.0 22:33:28 INFO - PROCESS | 4307 | 22:33:28 INFO - PROCESS | 4307 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:1.42 (2.1%) stddev-sans-first:1.48 22:33:28 INFO - PROCESS | 4307 | Values: 68.0 70.0 70.0 68.0 68.0 71.0 69.0 69.0 68.0 66.0 22:33:28 INFO - PROCESS | 4307 | -------- Summary: end -------- 22:33:28 INFO - PROCESS | 4307 | 22:33:29 INFO - TEST-INFO | 4307: exit 0 22:33:29 INFO - TEST-OK | kraken | took 58964ms 22:33:29 INFO - SUITE-END | took 1172s 22:33:29 INFO - Completed test suite (00:19:32) 22:33:29 INFO - Working with test: dromaeo_css 22:33:29 INFO - Generating results file: dromaeo_css 22:33:29 INFO - Working with test: kraken 22:33:29 INFO - Generating results file: kraken 22:33:29 INFO - javascript benchmark 22:33:29 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:33:29 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 22:33:29 INFO - process_Request line: dromaeo_css 6787.95 graph.html#tests=[[72,1,35]] 22:33:29 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:33:29 INFO - process_Request line: kraken 1515.50 graph.html#tests=[[232,1,35]] 22:33:29 INFO - RETURN: dromaeo_css: 6787.95 22:33:29 INFO - RETURN: kraken: 1515.50 22:33:29 INFO - javascript benchmark 22:33:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3165.066305439895, 3192.170035790694, 3225.8064516129034, 3227.2254658881875, 3251.1872031991993, 5090.211017292317, 5136.486351364862, 5148.195041223441, 5198.766055527505, 5243.2659427680155, 5171.198464238049, 5206.661566998143, 5228.660137091087, 5256.763445644946, 5284.233786101013, 4704.929426058612, 4716.740579268139, 4727.858164255078, 4743.335932969387, 4882.731449770279, 4822.734749588772, 4837.080954618629, 4850.514948505156, 4859.392575928009, 4873.098476781789, 4740.170470167707, 4760.904781904343, 4817.9759101204445, 4820.301056346845, 4879.780409881564, 4774.021325628238, 4779.784909679038, 4783.976080119612, 4802.687825291345, 4814.494478079786, 4725.952740472586, 4731.313959475891, 4735.100330937111, 4746.0, 4757.476677565465, 5047.0, 5084.339035925306, 5084.389873215201, 5154.07226699194, 5204.531592156686, 5592.217089607418, 5617.045102332613, 5618.57860660448, 5624.71876406178, 5631.521320687746, 5655.264815573949, 5661.575381846337, 5674.120511320752, 5676.347220069662, 5684.37471878093, 5175.353080864892, 5249.4488078751565, 5250.18622113573, 5250.632455728062, 5344.171653393731, 5721.199032135504, 5730.828075157752, 5736.225609542742, 5740.081586946152, 5785.82642520725, 5522.199281104217, 5530.5022547970875, 5531.0, 5531.529819965268, 5534.640248383842, 5616.269884914935, 5660.0, 5706.42935706426, 5707.200991861143, 5748.13777933305, 5457.5633949283965, 5498.202760599771, 5498.890022199614, 5503.669779813224, 5504.146857237135, 5461.262729531462, 5507.889842203133, 5509.146082357241, 5511.366192887869, 5542.972285138549, 4184.811683474251, 4230.111676547898, 4266.445362102907, 4276.807543660543, 4287.914241715211, 3784.394496880486, 3787.5644300905747, 3789.090618251655, 3819.6753275971296, 3833.4058220975794, 5178.6116041297055, 5180.533751962342, 5192.7403629818355, 5194.3766747990485, 5250.422453530108, 5517.089680202802, 5598.356189038232, 5600.60795744294, 5602.4957753802355, 5616.522595579421, 5166.974165129151, 5181.766820493087, 5184.818531351385, 5186.0, 5194.0910340690225, 4755.9286610700865, 4759.619230461555, 4760.024195040009, 4763.642726795504, 4799.016201678647, 5749.425057494217, 5784.8264552062665, 5813.098969659625, 5819.970900145472, 5835.35811060783, 5572.637778544382, 5573.665580065209, 5574.77700891976, 5577.0, 5605.271314729059, 5756.913646295393, 5775.855603609775, 5778.653280803165, 5781.479666829838, 5782.2483077199695, 5546.750396232099, 5564.638298510584, 5628.971855140698, 5632.352279487911, 5640.32316122068, 5557.166425036277, 5593.776248949996, 5594.104943209067, 5596.888062238814, 5600.215969764155, 5467.781288748405, 5468.671879687232, 5469.015577196143, 5471.343438787212, 5487.917681234864, 5447.155690867922, 5452.509274165344, 5453.918191227214, 5470.863228419322, 5508.697021663847, 5453.127499600045, 5459.962607104638, 5470.0, 5470.398256191896, 5509.311336082989, 5567.526760225426, 5574.637648552831, 5575.665460072409, 5576.442355764391, 5578.079616863172, 5359.946400535945, 5426.403095659553, 5430.8099216527235, 5441.809536666197, 5501.669899806025], "unit": "score", "name": "dojo.html", "value": 5166.567240207629}, {"lowerIsBetter": false, "replicates": [531.0838803064711, 556.8858384031269, 561.3993027460616, 562.6258538072182, 607.4866737606723, 28935.276618084532, 29432.411351772953, 36612.81693591532, 37243.441348379725, 37293.44059839105, 40413.39379909296, 40428.59571404285, 40680.0, 40703.79648101763, 40782.59217407825, 8430.07269200386, 8579.142085791433, 8631.43895646784, 8637.136286371375, 8637.438566493158, 8386.0, 8552.828943421127, 8569.0, 8572.314214862796, 8573.014103378098, 8708.390412671115, 8751.0, 8775.473471591693, 8778.341624378165, 8779.473231606093, 8682.609282582267, 8731.170538798804, 8737.519436430994, 8741.7814554636, 8752.993405758323, 8687.435316704394, 8803.691870784556, 8819.250363719091, 8819.338549608805, 8819.603117859648, 40506.594934050576, 41016.38475422871, 41062.794686026675, 41068.794656026825, 41107.38338924918, 3340.682635149657, 3500.597431295408, 3544.3620148373284, 3754.511913451261, 3880.553736320331, 28838.134855954355, 30669.53995690044, 31159.688403115906, 31233.37533249345, 31508.527372089437, 3350.1457128432094, 3769.246150769857, 3912.589178136283, 3978.244133614604, 4001.639852413297, 282719.0, 284470.0, 284872.57563712256, 285463.0, 285781.0, 52978.470215297355, 61961.0, 62146.0, 62434.37565624285, 62502.37497625056, 49113.0, 49116.0, 49141.26288105681, 49281.50718492841, 66323.0, 14517.85482145165, 14815.18516481604, 14948.40206391754, 14957.925210373878, 14958.0, 11223.0, 11291.153163512769, 11323.660290191307, 11324.6036388726, 11387.316760994367, 16553.917230414012, 16748.246328914985, 19637.60724785496, 20209.191632334543, 20757.37727868136, 7496.287852653989, 7638.694452221849, 7666.233376662401, 7769.961150194213, 7836.0, 876.3339861705023, 907.4328544659588, 961.6393852305386, 1007.5717819926502, 1053.8103141434615, 29478.705212947596, 29962.400751985275, 30159.849200753855, 30560.69439305623, 30665.386692266475, 1036.259074761549, 1043.415687215162, 1047.1936608811325, 1083.149727463937, 1171.5899435197782, 15451.459198927983, 15804.209789510478, 16003.119828409317, 16092.51722448305, 16730.74903876443, 385720.0, 390487.0, 391324.0, 393154.0, 393629.0, 55236.44763552313, 55910.72044639832, 55936.720316398154, 55984.16023759647, 56091.15863262054, 1268.7779638563215, 1270.7394984028251, 1277.4123903004722, 1284.6017734502148, 1294.9223046617233, 29946.550801737554, 31288.257791358577, 31347.686523135388, 31589.8420507896, 31731.0, 46305.53694463147, 46792.0, 46817.297740533235, 46914.0, 46936.0, 225035.0, 227363.0, 227504.0, 228142.0, 228375.0, 28342.0, 28577.428451430438, 31882.52176217405, 33032.17419564434, 33433.33133337271, 38967.610323897534, 39460.2107957845, 46865.76567117142, 48357.75821120872, 48844.26733598928, 34477.82761086179, 34616.82691586526, 34721.0, 34970.30059398849, 35445.64554354423, 35074.29851402907, 35272.29455410826, 35416.46875296821, 35458.0, 35594.0, 35271.294574108884, 35884.461733074546, 35970.558894618596, 37515.81242093772, 38816.41775373315, 31510.52734208943, 35784.46323305101, 35954.8202258987, 36001.0, 37914.43128353132, 26054.86972565201, 26591.468170636865, 26682.46635067249, 27139.72860271451, 28767.5684864723], "unit": "score", "name": "ext.html", "value": 18481.677993977966}, {"lowerIsBetter": false, "replicates": [353.7223279725415, 355.69410307135877, 359.5020896058958, 360.7402670077543, 363.9090227443139, 13573.321333933312, 13785.862141378584, 16263.674726505478, 17411.390601328956, 18297.35959241427, 15794.763078553802, 15896.410358964098, 16376.918115409406, 16379.344826206967, 16393.60654344382, 4666.976665116678, 4819.156647586676, 4838.782254798542, 4876.390451193601, 4878.585320247783, 3735.1969326594776, 3866.8646597369097, 4845.515448455161, 4882.2432522959, 5159.871003224931, 5247.2653828464045, 5248.0, 5249.212618107276, 5282.947170528284, 5312.814051508198, 5426.8914621707545, 5685.800996965107, 5866.032104702719, 5873.588848780587, 5882.588218824684, 4957.256411538262, 5128.8461346159675, 5151.0470562945975, 5162.354705661793, 5164.122099243138, 11502.769944601061, 11673.824892626617, 11745.4714537846, 14122.505712300122, 20095.598088038158, 2045.6215600114026, 2067.6795096760025, 2089.059923034625, 2135.6689713094497, 2178.6514157734687, 9095.226905712956, 9327.13457308541, 9360.578773955189, 9378.109079637423, 9585.856212156823, 1829.3780114761046, 1863.9906800466047, 1870.7568016157948, 1907.3229003703625, 1913.0912816412233, 57138.0, 58618.12072818868, 60095.39904600986, 60192.796144077314, 61010.0, 9552.37909535878, 9617.71146865595, 9677.806443871224, 9695.951520242495, 9777.706668799947, 12397.814032789516, 12505.49978000888, 12558.183718058479, 12559.623211303675, 12593.0, 6912.205096413876, 7036.859262814715, 7037.788866334018, 7073.964630176816, 7105.396041336441, 6825.1809782825385, 6851.520393572502, 6856.348646878539, 6877.862442751217, 6917.169939607179, 4088.8568900088353, 4123.628873401408, 4145.2124096421585, 4208.936865947013, 4429.291313389842, 1578.8500092491195, 1639.4507839873777, 1639.9098049607148, 1671.5319710481085, 1697.7623132761423, 447.72688659917424, 459.91491574058904, 930.6742640075919, 1009.5255230041869, 1025.6922923123034, 10398.532066056894, 10567.735806604896, 10782.245242833083, 10791.6222932197, 10886.29239099456, 457.43506769140083, 462.73624034300127, 465.51353835242253, 484.91271571116835, 892.9508877011697, 8757.56212189388, 9526.285528585384, 9571.473568953774, 9970.601175952881, 10039.297249192487, 351897.0, 355291.0, 357425.0, 547303.006214409, 549343.0, 72713.6364318175, 73810.63094684492, 73833.0, 76757.0, 77104.61447692725, 1173.7065733566608, 1173.9589114380956, 1224.1125184241355, 1227.9930457025332, 1246.5948566715854, 15898.205089745235, 15953.920230398773, 16113.436029738903, 16140.919295403448, 16386.75419868679, 32931.34137317193, 33148.0, 34129.65870341265, 34523.96428107161, 35338.0, 40518.59481405148, 41784.79107604564, 42626.0, 43132.56867431285, 43606.345904812086, 7329.706811727471, 7564.848703025798, 7644.273793989562, 7683.346915512244, 7713.382929365749, 10443.321184123008, 11933.522659093886, 12119.0, 12314.13801033919, 12393.938030309791, 7861.371090312647, 10132.44271565071, 10224.539895704562, 10266.332688375232, 10487.79024419492, 10202.540885660015, 10229.130523905551, 10278.691639250834, 10300.948495257475, 10440.060394564525, 3225.8064516129107, 4965.354503914468, 7791.571463569331, 10457.633982810565, 10773.559352527238, 7639.694412223449, 7656.310932016146, 7698.499597526143, 7748.883766743391, 7758.4181186410115, 8906.73279801607, 10763.569457221623, 10919.83620245681, 10938.835917461085, 11075.612353567587], "unit": "score", "name": "jquery.html", "value": 7701.340898652663}, {"lowerIsBetter": false, "replicates": [1353.1001883747297, 1472.0505274098207, 1502.9323680434377, 1673.4059408909836, 1814.5826459914229, 7190.8561828763395, 7363.705451781929, 7797.493162944412, 7954.125046244909, 7965.322947549465, 7877.0, 7892.447528672995, 7899.92100078999, 7914.3272821810215, 7928.3657307415415, 2017.1830408684507, 2070.834333253336, 2314.2131675230416, 2360.1031607989025, 2360.4688944987324, 2338.8012018978407, 2392.557376885282, 2395.6286775549816, 2399.400149962509, 2409.5301416223842, 2315.120254303371, 2344.824138189634, 2346.835721499496, 2348.6124789409814, 2360.24472168906, 2309.734380546242, 2318.5015221727326, 2327.848689835164, 2340.7659234076455, 2348.4833336665906, 2336.7663233676667, 2340.6020976434047, 2345.026813872241, 2350.471143992605, 2391.4858305464236, 8104.1085480597085, 8109.675612975474, 8128.1465446127895, 8131.878021829618, 8198.139195384458, 4822.132016237076, 4982.57648099912, 4983.526564976321, 4991.376077990251, 4995.650304478688, 3215.469447541153, 3233.1270556949494, 3251.821149836758, 3254.23525471514, 3279.2949515854207, 982.3761911186376, 1008.9445080520568, 1071.1216802222182, 1080.4543705428787, 1101.9228653994223, 11298.209125361229, 11477.253978491455, 11522.135839812048, 11542.249753765978, 11552.6534203974, 4410.470743510735, 4574.542545745466, 4689.320048593003, 4695.295705644181, 4759.095771803415, 8903.55482225886, 8947.642094316285, 8949.686760963335, 8961.641534338683, 8969.37214394986, 5041.773120209599, 5049.2930989660745, 5055.368078990126, 5056.393232812086, 5058.215976523645, 4558.430196225472, 4597.080583883237, 4598.977005114953, 4646.395968524138, 4651.837185698484, 3387.1532116970757, 3433.5879694436326, 3464.0993341731332, 3592.2456284180616, 3642.7814331140216, 1071.3036526257995, 1088.374184843718, 1090.2804149261608, 1093.9781204376027, 1098.7198264442675, 1017.0, 1023.4013102335217, 1024.0374048394635, 1121.6242558742913, 1319.3864852843474, 7470.626468676544, 7483.513571617827, 7510.887336689954, 7512.812179695551, 7520.774376768706, 1094.7755710079414, 1118.7091356247433, 1130.0733398613058, 1131.7365269461077, 1157.085902137319, 5958.880822383528, 6053.939460605426, 6065.5450841187085, 6076.574639775262, 6084.0, 9669.0, 10255.743606409751, 10398.844017339747, 10407.0, 10407.375557466576, 10140.847887281696, 10181.818181818182, 10285.43430111351, 10301.587936482456, 10302.948485257526, 7622.847543049108, 7701.191374905667, 7716.575588342583, 7876.881846772303, 7885.329746971572, 7295.562266264041, 7392.186859445349, 7435.182129965808, 7440.479166458296, 7448.73929412468, 8485.660573577235, 8526.104759000216, 8636.481811091355, 8720.651173953225, 8744.606492707717, 8708.608112635073, 8842.734717958472, 9090.454572725657, 9094.909050909406, 9155.77110572241, 7613.352865006536, 7719.6140192989005, 7727.381809455343, 7736.226377362219, 7738.651760670671, 6966.3730264276455, 7126.750563730245, 7301.379382752525, 7511.436642251962, 7513.323800857949, 7284.963575182091, 7322.3775979042375, 7335.486515944046, 7372.447066469929, 7474.701011959461, 7362.6318684066655, 7388.1503627083575, 7445.367143792621, 7496.362809161064, 7556.811079723051, 7396.0754905636795, 7429.33136017761, 7460.29127232912, 7490.176080631018, 7507.286807753255, 6752.392284694204, 6799.660016999229, 6805.489588280998, 6809.625470599165, 6816.556923799937, 6742.561733487308, 6799.898001529882, 6823.147106611674, 6834.384905358542, 6834.829129271808], "unit": "score", "name": "mootools.html", "value": 4646.911857045553}, {"lowerIsBetter": false, "replicates": [335.86061784359487, 337.80744975364024, 338.45677687311866, 340.8994346667733, 346.19855035592616, 5745.396733342996, 5770.04794208955, 5777.682227477487, 5782.3639399666, 5789.884202315951, 5726.770929162839, 5728.198052272674, 5735.483806457418, 5737.2541569596, 5756.079027355624, 4481.932771008429, 4493.573110554508, 4494.07871386365, 4494.4831344395325, 4496.033352829141, 4406.735595864258, 4484.439445069366, 4492.146492166478, 4495.910081798362, 4498.730076195422, 4424.402705634747, 4439.356293337464, 4439.622632076277, 4448.199324121657, 4460.018795864905, 4237.915241695179, 4329.805158767832, 4440.333949907524, 4445.68880178386, 4451.243288640939, 3871.1483473636035, 3895.474110995008, 3920.5099362579676, 3923.4114882767526, 3941.960580394188, 5381.354237491487, 5437.13005919055, 5478.58910581708, 5480.780768769245, 5486.31421072366, 4887.218045112801, 5003.249512573107, 5065.569426598743, 5153.896922061538, 5185.22221666753, 6008.24896887889, 6031.09533569968, 6045.818625441244, 6059.6364218147055, 6060.515158787286, 4307.203167414007, 4310.849120280806, 4311.094670119247, 4348.412964249817, 4366.803493842753, 6179.443850053472, 6339.017452294902, 6340.904886426707, 6352.205974253218, 6373.3945275198785, 4464.866054018385, 4466.731996080181, 4474.798634061475, 4476.283794592915, 4480.977595112004, 4537.115262523842, 4537.38745269391, 4540.364348991144, 4541.772911354486, 4542.954570454253, 5157.767900444489, 5166.147585648401, 5168.751593057033, 5170.689758614495, 5171.224316352577, 6040.124181993587, 6117.847053823601, 6152.415520525543, 6152.661603611844, 6153.907691384633, 1578.48699172767, 1591.2282542966652, 1597.1295643873884, 1601.9439319623991, 1603.350642989591, 1089.2701889733896, 1095.2388090277182, 1100.1089117814595, 1114.3091283404342, 1119.1662211652372, 5741.942580574224, 5757.625754325955, 5761.942380576224, 5763.942360576424, 5771.105478650816, 6232.906506402408, 6257.749690012349, 6269.435750782361, 6279.780207692709, 6284.183056202664, 5770.624909380961, 5771.711414429262, 5772.134179873053, 5774.566907481955, 5779.88440231193, 3296.3901678189613, 3381.120908563791, 3387.2886693794085, 3388.2715216228135, 3389.9661003390142, 6528.151340325728, 6529.510286728514, 6534.150560427114, 6540.345965403517, 6540.771073012517, 6251.499880009588, 6428.939225027912, 6432.839179020469, 6433.549651524442, 6435.7747478838955, 6371.808845734636, 6528.053432252297, 6583.308752581006, 6590.604563726191, 6611.603303801788, 6309.810705678837, 6343.873122537431, 6347.460465860454, 6347.587406818542, 6352.650604216812, 6101.694915254308, 6280.1207830902795, 6302.873942521032, 6303.842403939755, 6310.968445157745, 6636.469082473487, 6642.13652225227, 6644.534882558174, 6645.169353830771, 6652.501062420241, 4340.587644173798, 4366.716163449366, 4372.256716358163, 4377.693561450796, 4380.0, 6377.936220637735, 6394.584352017104, 6413.935860641333, 6439.613623182624, 6459.61242325462, 6052.6973651316375, 6223.0, 6227.626342419469, 6228.283747369111, 6243.063540468966, 6190.350013248544, 6191.659458729813, 6191.81424557264, 6192.81421557354, 6278.7488500461295, 6108.8778224436155, 6109.938900611115, 6110.297315808739, 6112.266528016667, 6119.724612392542, 6066.484348830399, 6267.185265915402, 6267.592606480564, 6272.686365681607, 6279.372062793684, 6113.969430152821, 6116.908246376397, 6122.2959359674205, 6122.938770612237, 6123.112148738319], "unit": "score", "name": "prototype.html", "value": 4657.421319094548}, {"lowerIsBetter": false, "replicates": [639.466045851714, 659.1233659233219, 734.7758933525276, 741.3920585120204, 742.3430264216167, 13973.161610303388, 14206.857931420684, 14230.786538201935, 14283.428662853486, 14289.857101428983, 14686.0, 15128.924355378234, 15137.924310378432, 15151.318190681419, 15156.696866062672, 683.5351960666744, 690.0, 808.1110778144039, 828.693383448125, 829.3696790439279, 777.327611615951, 781.9178986206451, 783.4163548156631, 784.2667106255669, 786.5713186313444, 872.6160489384682, 873.2359185712502, 873.6461732998146, 875.2472873328932, 875.5665945357057, 698.580851489105, 703.3423748794893, 825.0264687668549, 856.8157846063064, 873.2577309287055, 642.3576423576424, 643.1221382812428, 644.548815828917, 645.9192600924885, 647.491719000587, 12782.169159004636, 12789.232646041268, 12884.291363974977, 12956.157849739831, 12964.416601252966, 12079.57721479744, 12400.8139877901, 12561.497540098386, 12831.0, 13054.086213965027, 9957.302988790787, 9977.25170612207, 10136.149814522038, 10251.436171010591, 10510.159187265, 3311.3542859142476, 3381.9830900845336, 3397.065806903097, 3399.269157131204, 3453.620101788801, 53605.1959220612, 53813.19280210761, 54042.45957540453, 54074.72962635162, 54090.0, 9380.296477764196, 9471.242300615933, 9613.855792163124, 9796.216302695768, 9853.704388868346, 17258.741118883227, 17263.482095537154, 17335.393261235797, 17362.39231626912, 17380.130993450275, 7335.88996165058, 7410.740624078131, 7464.178940316561, 7494.100707915085, 7642.312191902755, 4196.307609244441, 4270.807813648394, 4323.156984388014, 4359.956400436018, 4361.105973275471, 3226.7741258111705, 3230.2570408806105, 3236.3527294541186, 3236.660150684191, 3248.9675103249137, 557.3395526301346, 564.176302598203, 574.1645905207912, 575.7524264566193, 578.9507891829157, 620.9316975132732, 631.9810405687837, 634.7365843175123, 638.9361063893573, 644.3009334871623, 7848.607569621496, 8092.554909480035, 8237.423380363436, 8291.304823579821, 8310.168983101763, 514.0, 523.5131327865046, 524.048851334826, 547.4771593128553, 614.2046050364788, 3427.8628854846024, 3521.5421995140982, 3563.625819288989, 3730.813459327023, 3899.512560929884, 54313.45686543163, 54769.72615136899, 57526.424735752946, 59167.70416147978, 59215.70392148098, 46623.0, 46786.76606617013, 46893.29660055102, 49038.509614904106, 49607.50392496101, 42687.99999999938, 42919.57080429218, 43134.13731725348, 43197.0, 43237.35143972843, 8292.61231762879, 8445.915540844513, 8625.137486251324, 8660.437071590326, 8682.131786821268, 35594.46608300826, 36504.26991460209, 36727.449088264235, 38251.0, 38321.4251786229, 45866.770666146454, 46217.306740399596, 46598.53401465942, 46739.0, 47599.76200119116, 10071.597136114766, 10080.445575493419, 10192.592296308065, 10421.739456513647, 10547.57809687604, 11246.775064498828, 11466.312021278416, 11538.961493465293, 11552.0, 11851.881481185077, 9892.901070989486, 10719.517621706886, 11034.889651103385, 11118.054965328038, 11258.718532036437, 10480.371177729055, 10674.46627668629, 10713.303635263683, 10790.67627971162, 10979.066779323528, 10514.211434142317, 10532.157427405637, 10699.625513107005, 10804.0, 10880.075193608633, 8625.482471051757, 8629.913700862911, 8700.60847261862, 8908.376413650982, 9008.459492430475, 8583.527905964982, 8766.824663506823, 8821.2060914518, 9105.135012173832, 9149.908500914906], "unit": "score", "name": "yui.html", "value": 6145.720299979321}], "name": "dromaeo_css", "value": 6787.9453326510775}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 112.0, 106.0, 111.0, 111.0, 111.0, 99.0, 110.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 108.9}, {"lowerIsBetter": true, "replicates": [151.0, 127.0, 149.0, 164.0, 129.0, 151.0, 146.0, 131.0, 168.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 144.3}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 162.0, 161.0, 160.0, 160.0, 161.0, 164.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [81.0, 73.0, 95.0, 93.0, 75.0, 73.0, 75.0, 109.0, 93.0, 76.0], "unit": "score", "name": "audio-fft", "value": 84.3}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 148.0, 95.0, 95.0, 96.0, 140.0, 95.0, 95.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 109.7}, {"lowerIsBetter": true, "replicates": [119.0, 115.0, 114.0, 115.0, 114.0, 115.0, 115.0, 115.0, 114.0, 114.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.0}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 147.0, 145.0, 146.0, 145.0, 146.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 57.0, 55.0, 55.0, 55.0, 57.0, 65.0, 53.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.3}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 68.0, 67.0, 67.0, 68.0, 67.0, 67.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.2}, {"lowerIsBetter": true, "replicates": [92.0, 86.0, 86.0, 85.0, 85.0, 86.0, 87.0, 87.0, 87.0, 89.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.0}, {"lowerIsBetter": true, "replicates": [117.0, 118.0, 121.0, 115.0, 126.0, 123.0, 124.0, 124.0, 114.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.1}, {"lowerIsBetter": true, "replicates": [152.0, 140.0, 150.0, 151.0, 150.0, 140.0, 162.0, 150.0, 151.0, 161.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.7}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 70.0, 68.0, 68.0, 71.0, 69.0, 69.0, 68.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.7}], "name": "kraken", "value": 1515.5}]} 22:33:29 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1515.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6787.95"}}} 22:33:29 INFO - Return code: 0 22:33:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 22:33:29 INFO - # TBPL SUCCESS # 22:33:29 INFO - Running post-action listener: _resource_record_post_action 22:33:29 INFO - Running post-run listener: _resource_record_post_run 22:33:30 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 479232; Write bytes: 288391168; Read time: 116; Write time: 226928 22:33:30 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 6455296; Read time: 0; Write time: 724 22:33:30 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 479232; Write bytes: 281935872; Read time: 116; Write time: 226204 22:33:30 INFO - Running post-run listener: _upload_blobber_files 22:33:30 INFO - Blob upload gear active. 22:33:30 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 22:33:30 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:33:30 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:33:30 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:33:31 INFO - (blobuploader) - INFO - Open directory for files ... 22:33:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 22:33:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:33:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:33:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:33:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:33:32 INFO - (blobuploader) - INFO - Done attempting. 22:33:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:33:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:33:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:33:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:33:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:33:33 INFO - (blobuploader) - INFO - Done attempting. 22:33:33 INFO - (blobuploader) - INFO - Iteration through files over. 22:33:33 INFO - Return code: 0 22:33:33 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 22:33:33 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 22:33:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8ac776bdfe05c68bc14b2b2a8cac3e97d230499c636ad82e0244e08f7542361c5abd71fe1eae1b212df5f7a251609223f91488e7c5f887012a2e34b33a0bc21", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/deae783c9dfbc2f4639201e0b71345bc97ab11560336fb8ffba8408b11ba3841747946c9e577fed73a5fb1948ed36e44fbd8e00bb0d9c89e0288fb3003165ba5"} 22:33:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 22:33:33 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 22:33:33 INFO - Contents: 22:33:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8ac776bdfe05c68bc14b2b2a8cac3e97d230499c636ad82e0244e08f7542361c5abd71fe1eae1b212df5f7a251609223f91488e7c5f887012a2e34b33a0bc21", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/deae783c9dfbc2f4639201e0b71345bc97ab11560336fb8ffba8408b11ba3841747946c9e577fed73a5fb1948ed36e44fbd8e00bb0d9c89e0288fb3003165ba5"} 22:33:33 INFO - Running post-run listener: copy_logs_to_upload_dir 22:33:33 INFO - Copying logs to upload dir... 22:33:33 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 22:33:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.238632 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-02-04 22:33:33.202023) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-04 22:33:33.205694) ========= 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=00204705a9daa57ed339a427000001b9-1454652072.156634-1829845297 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/d8ac776bdfe05c68bc14b2b2a8cac3e97d230499c636ad82e0244e08f7542361c5abd71fe1eae1b212df5f7a251609223f91488e7c5f887012a2e34b33a0bc21", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/deae783c9dfbc2f4639201e0b71345bc97ab11560336fb8ffba8408b11ba3841747946c9e577fed73a5fb1948ed36e44fbd8e00bb0d9c89e0288fb3003165ba5"} build_url:https://queue.taskcluster.net/v1/task/bvOsTzIOQ5yMrAOwphA7jw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011263 build_url: 'https://queue.taskcluster.net/v1/task/bvOsTzIOQ5yMrAOwphA7jw/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/d8ac776bdfe05c68bc14b2b2a8cac3e97d230499c636ad82e0244e08f7542361c5abd71fe1eae1b212df5f7a251609223f91488e7c5f887012a2e34b33a0bc21", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/deae783c9dfbc2f4639201e0b71345bc97ab11560336fb8ffba8408b11ba3841747946c9e577fed73a5fb1948ed36e44fbd8e00bb0d9c89e0288fb3003165ba5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-04 22:33:33.233633) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 22:33:33.233981) ========= 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=00204705a9daa57ed339a427000001b9-1454652072.156634-1829845297 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004456 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 22:33:33.318143) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-04 22:33:33.318592) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-04 22:33:33.318954) ========= ========= Total master_lag: 0.26 =========