builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-068 starttime: 1454306637.46 results: success (0) buildid: 20160131193211 builduid: 6aafc546296b4366bd5a57e379a40595 revision: bc49d41bd748ff4d86eb027b2a53c1eb8cecae8c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-31 22:03:57.464246) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-31 22:03:57.464667) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-31 22:03:57.464943) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1454302271.423393-2069714738 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006359 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-31 22:03:57.495487) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-31 22:03:57.495757) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-31 22:03:57.561423) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-31 22:03:57.561687) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1454302271.423393-2069714738 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.012829 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-31 22:03:57.612646) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-31 22:03:57.612915) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-31 22:03:57.613498) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-31 22:03:57.613831) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1454302271.423393-2069714738 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-31 22:03:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 63.7M=0s 2016-01-31 22:03:58 (63.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104539 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-31 22:03:57.730652) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-31 22:03:57.731009) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1454302271.423393-2069714738 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.084599 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-31 22:03:57.826704) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-31 22:03:57.827041) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev bc49d41bd748ff4d86eb027b2a53c1eb8cecae8c --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev bc49d41bd748ff4d86eb027b2a53c1eb8cecae8c --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=97facb8ba2ac28944cc45e6b000001d4-1454302271.423393-2069714738 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-31 22:03:58,659 truncating revision to first 12 chars 2016-01-31 22:03:58,660 Setting DEBUG logging. 2016-01-31 22:03:58,660 attempt 1/10 2016-01-31 22:03:58,660 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/bc49d41bd748?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-31 22:03:59,014 unpacking tar archive at: mozilla-inbound-bc49d41bd748/testing/mozharness/ program finished with exit code 0 elapsedTime=0.633047 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-31 22:03:58.472025) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-31 22:03:58.472364) ========= echo bc49d41bd748ff4d86eb027b2a53c1eb8cecae8c in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'bc49d41bd748ff4d86eb027b2a53c1eb8cecae8c'] 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=97facb8ba2ac28944cc45e6b000001d4-1454302271.423393-2069714738 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False bc49d41bd748ff4d86eb027b2a53c1eb8cecae8c program finished with exit code 0 elapsedTime=0.004624 script_repo_revision: 'bc49d41bd748ff4d86eb027b2a53c1eb8cecae8c' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-31 22:03:58.522826) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-31 22:03:58.523119) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-31 22:03:58.532802) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-01-31 22:03:58.533119) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=97facb8ba2ac28944cc45e6b000001d4-1454302271.423393-2069714738 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:03:59 INFO - MultiFileLogger online at 20160131 22:03:59 in /builds/slave/test-pgo 22:03:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 22:03:59 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:03:59 INFO - {'append_to_log': False, 22:03:59 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:03:59 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 22:03:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:03:59 INFO - 'branch': 'Mozilla-Inbound', 22:03:59 INFO - 'buildbot_json_path': 'buildprops.json', 22:03:59 INFO - 'config_files': ('talos/linux_config.py',), 22:03:59 INFO - 'default_actions': ('clobber', 22:03:59 INFO - 'read-buildbot-config', 22:03:59 INFO - 'download-and-extract', 22:03:59 INFO - 'populate-webroot', 22:03:59 INFO - 'create-virtualenv', 22:03:59 INFO - 'install', 22:03:59 INFO - 'run-tests'), 22:03:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:03:59 INFO - 'download_minidump_stackwalk': True, 22:03:59 INFO - 'download_symbols': 'ondemand', 22:03:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:03:59 INFO - 'tooltool.py': '/tools/tooltool.py', 22:03:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:03:59 INFO - '/tools/misc-python/virtualenv.py')}, 22:03:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:03:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:03:59 INFO - 'installer_path': 'installer.exe', 22:03:59 INFO - 'log_level': 'info', 22:03:59 INFO - 'log_name': 'talos', 22:03:59 INFO - 'log_to_console': True, 22:03:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:03:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:03:59 INFO - 'opt_config_files': (), 22:03:59 INFO - 'pip_index': False, 22:03:59 INFO - 'sps_profile': False, 22:03:59 INFO - 'sps_profile_interval': 0, 22:03:59 INFO - 'suite': 'dromaeojs', 22:03:59 INFO - 'system_bits': '32', 22:03:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:03:59 INFO - 'title': 'talos-linux64-ix-068', 22:03:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:03:59 INFO - 'use_talos_json': True, 22:03:59 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:03:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:03:59 INFO - 'work_dir': 'build'} 22:03:59 INFO - ##### 22:03:59 INFO - ##### Running clobber step. 22:03:59 INFO - ##### 22:03:59 INFO - Running pre-action listener: _resource_record_pre_action 22:03:59 INFO - Running main action method: clobber 22:03:59 INFO - rmtree: /builds/slave/test-pgo/build 22:03:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:04:00 INFO - Running post-action listener: _resource_record_post_action 22:04:00 INFO - ##### 22:04:00 INFO - ##### Running read-buildbot-config step. 22:04:00 INFO - ##### 22:04:00 INFO - Running pre-action listener: _resource_record_pre_action 22:04:00 INFO - Running main action method: read_buildbot_config 22:04:00 INFO - Using buildbot properties: 22:04:00 INFO - { 22:04:00 INFO - "project": "", 22:04:00 INFO - "product": "firefox", 22:04:00 INFO - "script_repo_revision": "production", 22:04:00 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 22:04:00 INFO - "repository": "", 22:04:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 22:04:00 INFO - "buildid": "20160131193211", 22:04:00 INFO - "pgo_build": "True", 22:04:00 INFO - "basedir": "/builds/slave/test-pgo", 22:04:00 INFO - "buildnumber": 1470, 22:04:00 INFO - "slavename": "talos-linux64-ix-068", 22:04:00 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:04:00 INFO - "platform": "ubuntu64_hw", 22:04:00 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 22:04:00 INFO - "branch": "mozilla-inbound", 22:04:00 INFO - "repo_path": "integration/mozilla-inbound", 22:04:00 INFO - "revision": "bc49d41bd748ff4d86eb027b2a53c1eb8cecae8c", 22:04:00 INFO - "stage_platform": "linux64-pgo", 22:04:00 INFO - "builduid": "6aafc546296b4366bd5a57e379a40595", 22:04:00 INFO - "slavebuilddir": "test" 22:04:00 INFO - } 22:04:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/SaYEH2gJQZWugE5-HzWKXA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 22:04:00 INFO - Running post-action listener: _resource_record_post_action 22:04:00 INFO - ##### 22:04:00 INFO - ##### Running download-and-extract step. 22:04:00 INFO - ##### 22:04:00 INFO - Running pre-action listener: _resource_record_pre_action 22:04:00 INFO - Running main action method: download_and_extract 22:04:00 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:04:00 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:04:00 INFO - https://queue.taskcluster.net/v1/task/SaYEH2gJQZWugE5-HzWKXA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:04:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaYEH2gJQZWugE5-HzWKXA/artifacts/public/build/test_packages.json 22:04:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaYEH2gJQZWugE5-HzWKXA/artifacts/public/build/test_packages.json 22:04:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaYEH2gJQZWugE5-HzWKXA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 22:04:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaYEH2gJQZWugE5-HzWKXA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 22:04:02 INFO - Downloaded 1448 bytes. 22:04:02 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 22:04:02 INFO - Using the following test package requirements: 22:04:02 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 22:04:02 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:04:02 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:04:02 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:04:02 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:04:02 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:04:02 INFO - u'jsshell-linux-x86_64.zip'], 22:04:02 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:04:02 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:04:02 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 22:04:02 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:04:02 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:04:02 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:04:02 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:04:02 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:04:02 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:04:02 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 22:04:02 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:04:02 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:04:02 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:04:02 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:04:02 INFO - https://queue.taskcluster.net/v1/task/SaYEH2gJQZWugE5-HzWKXA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:04:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaYEH2gJQZWugE5-HzWKXA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:04:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaYEH2gJQZWugE5-HzWKXA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:04:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaYEH2gJQZWugE5-HzWKXA/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:04:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaYEH2gJQZWugE5-HzWKXA/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:04:04 INFO - Downloaded 22937371 bytes. 22:04:04 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:04:04 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:04:05 INFO - Return code: 0 22:04:05 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:04:05 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:04:05 INFO - https://queue.taskcluster.net/v1/task/SaYEH2gJQZWugE5-HzWKXA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:04:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaYEH2gJQZWugE5-HzWKXA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:04:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaYEH2gJQZWugE5-HzWKXA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:04:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaYEH2gJQZWugE5-HzWKXA/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:04:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaYEH2gJQZWugE5-HzWKXA/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:04:09 INFO - Downloaded 22937371 bytes. 22:04: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:04: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:04:11 INFO - Return code: 0 22:04:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:11 INFO - https://queue.taskcluster.net/v1/task/SaYEH2gJQZWugE5-HzWKXA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:04:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaYEH2gJQZWugE5-HzWKXA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 22:04:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaYEH2gJQZWugE5-HzWKXA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 22:04:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaYEH2gJQZWugE5-HzWKXA/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:04:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaYEH2gJQZWugE5-HzWKXA/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:04:12 INFO - Downloaded 10706582 bytes. 22:04: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:04: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:04:12 INFO - Return code: 0 22:04: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:04:12 INFO - https://queue.taskcluster.net/v1/task/SaYEH2gJQZWugE5-HzWKXA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:04:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaYEH2gJQZWugE5-HzWKXA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:04:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaYEH2gJQZWugE5-HzWKXA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:04:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaYEH2gJQZWugE5-HzWKXA/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:04:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaYEH2gJQZWugE5-HzWKXA/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:04:13 INFO - Downloaded 56106864 bytes. 22:04:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SaYEH2gJQZWugE5-HzWKXA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:04:13 INFO - mkdir: /builds/slave/test-pgo/properties 22:04:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:04:13 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:04:13 INFO - Contents: 22:04:13 INFO - build_url:https://queue.taskcluster.net/v1/task/SaYEH2gJQZWugE5-HzWKXA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:04:13 INFO - Running post-action listener: _resource_record_post_action 22:04:13 INFO - Running post-action listener: set_extra_try_arguments 22:04:13 INFO - ##### 22:04:13 INFO - ##### Running populate-webroot step. 22:04:13 INFO - ##### 22:04:13 INFO - Running pre-action listener: _resource_record_pre_action 22:04:13 INFO - Running main action method: populate_webroot 22:04:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:04:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:04:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:04:13 INFO - '--tppagecycles', 22:04:13 INFO - '7'], 22:04:13 INFO - 'tests': ['tsvgm']}}, 22:04:13 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:04:13 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:04:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:04:13 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 22:04:13 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:04:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:04:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:04:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:04:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:04:13 INFO - 'talos_options': ['--e10s'], 22:04:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:04:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:04:13 INFO - 'tests': ['damp', 'tps']}, 22:04:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:04:13 INFO - 'talos_options': ['--e10s'], 22:04:13 INFO - 'tests': ['damp', 'tps']}, 22:04:13 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:04:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:04:13 INFO - 'other': {'tests': ['a11yr', 22:04:13 INFO - 'ts_paint', 22:04:13 INFO - 'tpaint', 22:04:13 INFO - 'sessionrestore', 22:04:13 INFO - 'sessionrestore_no_auto_restore']}, 22:04:13 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:04:13 INFO - 'tests': ['a11yr', 22:04:13 INFO - 'ts_paint', 22:04:13 INFO - 'tpaint', 22:04:13 INFO - 'sessionrestore', 22:04:13 INFO - 'sessionrestore_no_auto_restore']}, 22:04:13 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:04:13 INFO - 'tests': ['a11yr', 22:04:13 INFO - 'ts_paint', 22:04:13 INFO - 'tpaint', 22:04:13 INFO - 'sessionrestore', 22:04:13 INFO - 'sessionrestore_no_auto_restore']}, 22:04:13 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:04:13 INFO - 'tests': ['a11yr', 22:04:13 INFO - 'ts_paint', 22:04:13 INFO - 'tpaint', 22:04:13 INFO - 'sessionrestore', 22:04:13 INFO - 'sessionrestore_no_auto_restore']}, 22:04:13 INFO - 'other_l64': {'tests': ['a11yr', 22:04:13 INFO - 'ts_paint', 22:04:13 INFO - 'tpaint', 22:04:13 INFO - 'sessionrestore', 22:04:13 INFO - 'sessionrestore_no_auto_restore']}, 22:04:13 INFO - 'other_nol64': {'tests': ['a11yr', 22:04:13 INFO - 'ts_paint', 22:04:13 INFO - 'tpaint', 22:04:13 INFO - 'sessionrestore', 22:04:13 INFO - 'sessionrestore_no_auto_restore']}, 22:04:13 INFO - 'svgr': {'tests': ['tsvgx', 22:04:13 INFO - 'tsvgr_opacity', 22:04:13 INFO - 'tart', 22:04:13 INFO - 'tscrollx', 22:04:13 INFO - 'cart']}, 22:04:13 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:04:13 INFO - 'tests': ['tsvgx', 22:04:13 INFO - 'tsvgr_opacity', 22:04:13 INFO - 'tart', 22:04:13 INFO - 'tscrollx', 22:04:13 INFO - 'cart']}, 22:04:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:04:13 INFO - 'tests': ['tp5o']}, 22:04:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:04:13 INFO - 'talos_options': ['--e10s'], 22:04:13 INFO - 'tests': ['tp5o']}, 22:04:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:04:13 INFO - 'talos_options': ['--xperf_path', 22:04:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:04:13 INFO - 'tests': ['tp5n']}, 22:04:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:04:13 INFO - 'talos_options': ['--e10s', 22:04:13 INFO - '--xperf_path', 22:04:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:04:13 INFO - 'tests': ['tp5n']}}, 22:04:13 INFO - 'talos.zip': {'path': '', 22:04:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:04:13 INFO - Running post-action listener: _resource_record_post_action 22:04:13 INFO - ##### 22:04:13 INFO - ##### Running create-virtualenv step. 22:04:13 INFO - ##### 22:04:13 INFO - Running pre-action listener: _resource_record_pre_action 22:04:13 INFO - Running main action method: create_virtualenv 22:04:13 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:04:13 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:04:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:04:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:04:13 INFO - Using real prefix '/usr' 22:04:13 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:04:14 INFO - Installing distribute.............................................................................................................................................................................................done. 22:04:16 INFO - Installing pip.................done. 22:04:16 INFO - Return code: 0 22:04:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:04:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:04:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:04:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:16 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 0x7f5721702f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c777f0>, '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 0x1be32d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be3760>, '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': '97facb8ba2ac28944cc45e6b000001d4-1454302271.423393-2069714738', '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:04:16 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:04:16 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:04:16 INFO - Using env: {'DISPLAY': ':0', 22:04:16 INFO - 'HOME': '/home/cltbld', 22:04:16 INFO - 'LANG': 'en_US.UTF-8', 22:04:16 INFO - 'LANGUAGE': 'en_US:en', 22:04:16 INFO - 'LOGNAME': 'cltbld', 22:04:16 INFO - 'MAIL': '/var/mail/cltbld', 22:04:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:04:16 INFO - 'MOZ_NO_REMOTE': '1', 22:04:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:04:16 INFO - 'NO_EM_RESTART': '1', 22:04:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:04:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:04:16 INFO - 'PWD': '/builds/slave/test-pgo', 22:04:16 INFO - 'SHELL': '/bin/bash', 22:04:16 INFO - 'SHLVL': '1', 22:04:16 INFO - 'TERM': 'linux', 22:04:16 INFO - 'TMOUT': '86400', 22:04:16 INFO - 'USER': 'cltbld', 22:04:16 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1454302271.423393-2069714738', 22:04:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:04:16 INFO - '_': '/tools/buildbot/bin/python'} 22:04:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:04:16 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:04:16 INFO - Cleaning up... 22:04:16 INFO - Return code: 0 22:04:16 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:04:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:04:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:04:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:16 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 0x7f5721702f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c777f0>, '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 0x1be32d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be3760>, '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': '97facb8ba2ac28944cc45e6b000001d4-1454302271.423393-2069714738', '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:04:16 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:04:16 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:04:16 INFO - Using env: {'DISPLAY': ':0', 22:04:16 INFO - 'HOME': '/home/cltbld', 22:04:16 INFO - 'LANG': 'en_US.UTF-8', 22:04:16 INFO - 'LANGUAGE': 'en_US:en', 22:04:16 INFO - 'LOGNAME': 'cltbld', 22:04:16 INFO - 'MAIL': '/var/mail/cltbld', 22:04:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:04:16 INFO - 'MOZ_NO_REMOTE': '1', 22:04:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:04:16 INFO - 'NO_EM_RESTART': '1', 22:04:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:04:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:04:16 INFO - 'PWD': '/builds/slave/test-pgo', 22:04:16 INFO - 'SHELL': '/bin/bash', 22:04:16 INFO - 'SHLVL': '1', 22:04:16 INFO - 'TERM': 'linux', 22:04:16 INFO - 'TMOUT': '86400', 22:04:16 INFO - 'USER': 'cltbld', 22:04:16 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1454302271.423393-2069714738', 22:04:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:04:16 INFO - '_': '/tools/buildbot/bin/python'} 22:04:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:04:16 INFO - Downloading/unpacking psutil>=0.7.1 22:04:16 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:04:16 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:04:16 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:04:16 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:04:16 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:04:16 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:04:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:04:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:04:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:04:18 INFO - Installing collected packages: psutil 22:04:18 INFO - Running setup.py install for psutil 22:04:18 INFO - building 'psutil._psutil_linux' extension 22:04:18 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:04:19 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:04:19 INFO - building 'psutil._psutil_posix' extension 22:04:19 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:04:19 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:04:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:04:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:04:19 INFO - Successfully installed psutil 22:04:19 INFO - Cleaning up... 22:04:19 INFO - Return code: 0 22:04:19 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:04:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:04:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:04:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:19 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 0x7f5721702f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c777f0>, '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 0x1be32d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be3760>, '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': '97facb8ba2ac28944cc45e6b000001d4-1454302271.423393-2069714738', '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:04:19 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:04:19 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:04:19 INFO - Using env: {'DISPLAY': ':0', 22:04:19 INFO - 'HOME': '/home/cltbld', 22:04:19 INFO - 'LANG': 'en_US.UTF-8', 22:04:19 INFO - 'LANGUAGE': 'en_US:en', 22:04:19 INFO - 'LOGNAME': 'cltbld', 22:04:19 INFO - 'MAIL': '/var/mail/cltbld', 22:04:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:04:19 INFO - 'MOZ_NO_REMOTE': '1', 22:04:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:04:19 INFO - 'NO_EM_RESTART': '1', 22:04:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:04:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:04:19 INFO - 'PWD': '/builds/slave/test-pgo', 22:04:19 INFO - 'SHELL': '/bin/bash', 22:04:19 INFO - 'SHLVL': '1', 22:04:19 INFO - 'TERM': 'linux', 22:04:19 INFO - 'TMOUT': '86400', 22:04:19 INFO - 'USER': 'cltbld', 22:04:19 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1454302271.423393-2069714738', 22:04:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:04:19 INFO - '_': '/tools/buildbot/bin/python'} 22:04:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:04:19 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:04:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:04:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:04:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:04:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:04:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:04:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:04:21 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:04:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:04:21 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:04:21 INFO - Installing collected packages: mozsystemmonitor 22:04:21 INFO - Running setup.py install for mozsystemmonitor 22:04:21 INFO - Successfully installed mozsystemmonitor 22:04:21 INFO - Cleaning up... 22:04:21 INFO - Return code: 0 22:04:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:04: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:04:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:04:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04: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:04:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:04:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:21 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 0x7f5721702f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c777f0>, '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 0x1be32d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be3760>, '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': '97facb8ba2ac28944cc45e6b000001d4-1454302271.423393-2069714738', '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:04:21 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:04:21 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:04:21 INFO - Using env: {'DISPLAY': ':0', 22:04:21 INFO - 'HOME': '/home/cltbld', 22:04:21 INFO - 'LANG': 'en_US.UTF-8', 22:04:21 INFO - 'LANGUAGE': 'en_US:en', 22:04:21 INFO - 'LOGNAME': 'cltbld', 22:04:21 INFO - 'MAIL': '/var/mail/cltbld', 22:04:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:04:21 INFO - 'MOZ_NO_REMOTE': '1', 22:04:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:04:21 INFO - 'NO_EM_RESTART': '1', 22:04:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:04:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:04:21 INFO - 'PWD': '/builds/slave/test-pgo', 22:04:21 INFO - 'SHELL': '/bin/bash', 22:04:21 INFO - 'SHLVL': '1', 22:04:21 INFO - 'TERM': 'linux', 22:04:21 INFO - 'TMOUT': '86400', 22:04:21 INFO - 'USER': 'cltbld', 22:04:21 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1454302271.423393-2069714738', 22:04:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:04:21 INFO - '_': '/tools/buildbot/bin/python'} 22:04:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:04:21 INFO - Downloading/unpacking blobuploader==1.2.4 22:04:21 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:04:21 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:04:21 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:04:21 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:04:21 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:04:21 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:04:23 INFO - Downloading blobuploader-1.2.4.tar.gz 22:04:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:04:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:04: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:04: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:04: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:04: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:04: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:04: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:04:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:04:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:04:24 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:04:24 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:04:24 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:04:24 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:04:24 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:04:24 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:04:24 INFO - Downloading docopt-0.6.1.tar.gz 22:04:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:04:24 INFO - Installing collected packages: blobuploader, requests, docopt 22:04:24 INFO - Running setup.py install for blobuploader 22:04:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:04:24 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:04:24 INFO - Running setup.py install for requests 22:04:24 INFO - Running setup.py install for docopt 22:04:24 INFO - Successfully installed blobuploader requests docopt 22:04:24 INFO - Cleaning up... 22:04:24 INFO - Return code: 0 22:04:24 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:04:24 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:04:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:04:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:24 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:04:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:04:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:24 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 0x7f5721702f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c777f0>, '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 0x1be32d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be3760>, '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': '97facb8ba2ac28944cc45e6b000001d4-1454302271.423393-2069714738', '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:04:24 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:04:24 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:04:24 INFO - Using env: {'DISPLAY': ':0', 22:04:24 INFO - 'HOME': '/home/cltbld', 22:04:24 INFO - 'LANG': 'en_US.UTF-8', 22:04:24 INFO - 'LANGUAGE': 'en_US:en', 22:04:24 INFO - 'LOGNAME': 'cltbld', 22:04:24 INFO - 'MAIL': '/var/mail/cltbld', 22:04:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:04:24 INFO - 'MOZ_NO_REMOTE': '1', 22:04:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:04:24 INFO - 'NO_EM_RESTART': '1', 22:04:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:04:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:04:24 INFO - 'PWD': '/builds/slave/test-pgo', 22:04:24 INFO - 'SHELL': '/bin/bash', 22:04:24 INFO - 'SHLVL': '1', 22:04:24 INFO - 'TERM': 'linux', 22:04:24 INFO - 'TMOUT': '86400', 22:04:24 INFO - 'USER': 'cltbld', 22:04:24 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1454302271.423393-2069714738', 22:04:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:04:24 INFO - '_': '/tools/buildbot/bin/python'} 22:04:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:04:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:04:25 INFO - Running setup.py (path:/tmp/pip-8YvZf8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:04:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:04:25 INFO - Running setup.py (path:/tmp/pip-uveaRH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:04:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:04:25 INFO - Running setup.py (path:/tmp/pip-MRhyNL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:04:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:04:25 INFO - Running setup.py (path:/tmp/pip-0dulWd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:04:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:04:25 INFO - Running setup.py (path:/tmp/pip-fSaAes-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:04:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:04:25 INFO - Running setup.py (path:/tmp/pip-TWF9g3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:04:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:04:25 INFO - Running setup.py (path:/tmp/pip-4PwTF1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:04:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:04:25 INFO - Running setup.py (path:/tmp/pip-GMdKCu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:04:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:04:25 INFO - Running setup.py (path:/tmp/pip-P8l31X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:04:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:04:25 INFO - Running setup.py (path:/tmp/pip-UDTstt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:04:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:04:25 INFO - Running setup.py (path:/tmp/pip-ZDjgnc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:04:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:04:25 INFO - Running setup.py (path:/tmp/pip-Bmquga-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:04:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:04:26 INFO - Running setup.py (path:/tmp/pip-3thkld-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:04:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:04:26 INFO - Running setup.py (path:/tmp/pip-DEBMAe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:04:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:04:26 INFO - Running setup.py (path:/tmp/pip-xNmkKv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:04:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:04:26 INFO - Running setup.py (path:/tmp/pip-slkjxL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:04:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:04:26 INFO - Running setup.py (path:/tmp/pip-K0CWUi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:04:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:04:26 INFO - Running setup.py install for manifestparser 22:04:26 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:04:26 INFO - Running setup.py install for mozcrash 22:04:26 INFO - Running setup.py install for mozdebug 22:04:26 INFO - Running setup.py install for mozdevice 22:04:26 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:04:26 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:04:26 INFO - Running setup.py install for mozfile 22:04:26 INFO - Running setup.py install for mozhttpd 22:04:26 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:04:26 INFO - Running setup.py install for mozinfo 22:04:27 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:04:27 INFO - Running setup.py install for mozInstall 22:04:27 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:04:27 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:04:27 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:04:27 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:04:27 INFO - Running setup.py install for mozleak 22:04:27 INFO - Running setup.py install for mozlog 22:04:27 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:04:27 INFO - Running setup.py install for moznetwork 22:04:27 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:04:27 INFO - Running setup.py install for mozprocess 22:04:27 INFO - Running setup.py install for mozprofile 22:04:27 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:04:27 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:04:27 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:04:27 INFO - Running setup.py install for mozrunner 22:04:27 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:04:27 INFO - Running setup.py install for mozscreenshot 22:04:27 INFO - Running setup.py install for moztest 22:04:28 INFO - Running setup.py install for mozversion 22:04:28 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:04:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:04:28 INFO - Cleaning up... 22:04:28 INFO - Return code: 0 22:04:28 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:04:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:04:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:04:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:28 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 0x7f5721702f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c777f0>, '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 0x1be32d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be3760>, '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': '97facb8ba2ac28944cc45e6b000001d4-1454302271.423393-2069714738', '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:04:28 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:04:28 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:04:28 INFO - Using env: {'DISPLAY': ':0', 22:04:28 INFO - 'HOME': '/home/cltbld', 22:04:28 INFO - 'LANG': 'en_US.UTF-8', 22:04:28 INFO - 'LANGUAGE': 'en_US:en', 22:04:28 INFO - 'LOGNAME': 'cltbld', 22:04:28 INFO - 'MAIL': '/var/mail/cltbld', 22:04:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:04:28 INFO - 'MOZ_NO_REMOTE': '1', 22:04:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:04:28 INFO - 'NO_EM_RESTART': '1', 22:04:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:04:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:04:28 INFO - 'PWD': '/builds/slave/test-pgo', 22:04:28 INFO - 'SHELL': '/bin/bash', 22:04:28 INFO - 'SHLVL': '1', 22:04:28 INFO - 'TERM': 'linux', 22:04:28 INFO - 'TMOUT': '86400', 22:04:28 INFO - 'USER': 'cltbld', 22:04:28 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1454302271.423393-2069714738', 22:04:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:04:28 INFO - '_': '/tools/buildbot/bin/python'} 22:04:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:04:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:04:28 INFO - Running setup.py (path:/tmp/pip-9zu53b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:04:28 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:04:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:04:28 INFO - Running setup.py (path:/tmp/pip-gMqgCY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:04:28 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:04:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:04:28 INFO - Running setup.py (path:/tmp/pip-iaWQE4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:04:28 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:04:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:04:28 INFO - Running setup.py (path:/tmp/pip-fpg5zK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:04:28 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:04:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:04:28 INFO - Running setup.py (path:/tmp/pip-qzss7r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:04:28 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:04:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:04:28 INFO - Running setup.py (path:/tmp/pip-oGPCwG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:04:28 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:04:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:04:28 INFO - Running setup.py (path:/tmp/pip-lmoomP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:04:28 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:04:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:04:28 INFO - Running setup.py (path:/tmp/pip-cXd9VB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:04:28 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:04:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:04:28 INFO - Running setup.py (path:/tmp/pip-L_8gNt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:04:28 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:04:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:04:29 INFO - Running setup.py (path:/tmp/pip-fyLvnL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:04:29 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:04:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:04:29 INFO - Running setup.py (path:/tmp/pip-ibUPzQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:04:29 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:04:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:04:29 INFO - Running setup.py (path:/tmp/pip-45u5c8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:04:29 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:04:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:04:29 INFO - Running setup.py (path:/tmp/pip-rS8XjL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:04:29 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:04:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:04:29 INFO - Running setup.py (path:/tmp/pip-eae8qr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:04:29 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:04:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:04:29 INFO - Running setup.py (path:/tmp/pip-DybQhZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:04:29 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:04:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:04:29 INFO - Running setup.py (path:/tmp/pip-dOp9ki-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:04:29 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:04:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:04:29 INFO - Running setup.py (path:/tmp/pip-poaEsJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:04:29 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:04:29 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:04:29 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:04:29 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:04:29 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:04:29 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:04:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:04:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:04:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:04:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:04:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:04:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:04:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:04:31 INFO - Downloading blessings-1.6.tar.gz 22:04:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:04:31 INFO - Installing collected packages: blessings 22:04:31 INFO - Running setup.py install for blessings 22:04:31 INFO - Successfully installed blessings 22:04:31 INFO - Cleaning up... 22:04:31 INFO - Return code: 0 22:04:31 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:04:31 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:04:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:04:31 INFO - Reading from file tmpfile_stdout 22:04:31 INFO - Current package versions: 22:04:31 INFO - argparse == 1.2.1 22:04:31 INFO - blessings == 1.6 22:04:31 INFO - blobuploader == 1.2.4 22:04:31 INFO - docopt == 0.6.1 22:04:31 INFO - manifestparser == 1.1 22:04:31 INFO - mozInstall == 1.12 22:04:31 INFO - mozcrash == 0.16 22:04:31 INFO - mozdebug == 0.1 22:04:31 INFO - mozdevice == 0.48 22:04:31 INFO - mozfile == 1.2 22:04:31 INFO - mozhttpd == 0.7 22:04:31 INFO - mozinfo == 0.9 22:04:31 INFO - mozleak == 0.1 22:04:31 INFO - mozlog == 3.1 22:04:31 INFO - moznetwork == 0.27 22:04:31 INFO - mozprocess == 0.22 22:04:31 INFO - mozprofile == 0.28 22:04:31 INFO - mozrunner == 6.11 22:04:31 INFO - mozscreenshot == 0.1 22:04:31 INFO - mozsystemmonitor == 0.0 22:04:31 INFO - moztest == 0.7 22:04:31 INFO - mozversion == 1.4 22:04:31 INFO - psutil == 3.1.1 22:04:31 INFO - requests == 1.2.3 22:04:31 INFO - wsgiref == 0.1.2 22:04:31 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:04:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:04:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:04:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:31 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 0x7f5721702f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c777f0>, '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 0x1be32d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be3760>, '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': '97facb8ba2ac28944cc45e6b000001d4-1454302271.423393-2069714738', '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:04:31 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:04:31 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:04:31 INFO - Using env: {'DISPLAY': ':0', 22:04:31 INFO - 'HOME': '/home/cltbld', 22:04:31 INFO - 'LANG': 'en_US.UTF-8', 22:04:31 INFO - 'LANGUAGE': 'en_US:en', 22:04:31 INFO - 'LOGNAME': 'cltbld', 22:04:31 INFO - 'MAIL': '/var/mail/cltbld', 22:04:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:04:31 INFO - 'MOZ_NO_REMOTE': '1', 22:04:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:04:31 INFO - 'NO_EM_RESTART': '1', 22:04:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:04:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:04:31 INFO - 'PWD': '/builds/slave/test-pgo', 22:04:31 INFO - 'SHELL': '/bin/bash', 22:04:31 INFO - 'SHLVL': '1', 22:04:31 INFO - 'TERM': 'linux', 22:04:31 INFO - 'TMOUT': '86400', 22:04:31 INFO - 'USER': 'cltbld', 22:04:31 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1454302271.423393-2069714738', 22:04:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:04:31 INFO - '_': '/tools/buildbot/bin/python'} 22:04:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:04:32 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:04:32 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:04:32 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:04:32 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:04:32 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:04:32 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:04:32 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:04:32 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:04:32 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:04:32 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:04:32 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:04:32 INFO - Cleaning up... 22:04:32 INFO - Return code: 0 22:04:32 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:04:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:04:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:04:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:32 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 0x7f5721702f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c777f0>, '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 0x1be32d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be3760>, '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': '97facb8ba2ac28944cc45e6b000001d4-1454302271.423393-2069714738', '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:04:32 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:04:32 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:04:32 INFO - Using env: {'DISPLAY': ':0', 22:04:32 INFO - 'HOME': '/home/cltbld', 22:04:32 INFO - 'LANG': 'en_US.UTF-8', 22:04:32 INFO - 'LANGUAGE': 'en_US:en', 22:04:32 INFO - 'LOGNAME': 'cltbld', 22:04:32 INFO - 'MAIL': '/var/mail/cltbld', 22:04:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:04:32 INFO - 'MOZ_NO_REMOTE': '1', 22:04:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:04:32 INFO - 'NO_EM_RESTART': '1', 22:04:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:04:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:04:32 INFO - 'PWD': '/builds/slave/test-pgo', 22:04:32 INFO - 'SHELL': '/bin/bash', 22:04:32 INFO - 'SHLVL': '1', 22:04:32 INFO - 'TERM': 'linux', 22:04:32 INFO - 'TMOUT': '86400', 22:04:32 INFO - 'USER': 'cltbld', 22:04:32 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1454302271.423393-2069714738', 22:04:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:04:32 INFO - '_': '/tools/buildbot/bin/python'} 22:04:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:04:32 INFO - Downloading/unpacking jsonschema 22:04:32 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:04:32 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:04:32 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:04:32 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:04:32 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:04:32 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:04:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:04:33 INFO - Downloading/unpacking functools32 (from jsonschema) 22:04: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:04: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:04: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:04: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:04: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:04: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:04:34 INFO - Downloading functools32-3.2.3-2.tar.gz 22:04:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:04:34 INFO - warning: no files found matching '*.txt' 22:04:34 INFO - no previously-included directories found matching 'build' 22:04:34 INFO - no previously-included directories found matching 'dist' 22:04:34 INFO - no previously-included directories found matching '.git*' 22:04:34 INFO - Installing collected packages: jsonschema, functools32 22:04:34 INFO - Running setup.py install for functools32 22:04:34 INFO - warning: no files found matching '*.txt' 22:04:34 INFO - no previously-included directories found matching 'build' 22:04:34 INFO - no previously-included directories found matching 'dist' 22:04:34 INFO - no previously-included directories found matching '.git*' 22:04:34 INFO - Successfully installed jsonschema functools32 22:04:34 INFO - Cleaning up... 22:04:34 INFO - Return code: 0 22:04:34 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:04:34 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:04:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:04:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:34 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:04:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:04:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:34 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 0x7f5721702f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c777f0>, '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 0x1be32d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be3760>, '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': '97facb8ba2ac28944cc45e6b000001d4-1454302271.423393-2069714738', '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:04:34 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:04:34 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:04:34 INFO - Using env: {'DISPLAY': ':0', 22:04:34 INFO - 'HOME': '/home/cltbld', 22:04:34 INFO - 'LANG': 'en_US.UTF-8', 22:04:34 INFO - 'LANGUAGE': 'en_US:en', 22:04:34 INFO - 'LOGNAME': 'cltbld', 22:04:34 INFO - 'MAIL': '/var/mail/cltbld', 22:04:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:04:34 INFO - 'MOZ_NO_REMOTE': '1', 22:04:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:04:34 INFO - 'NO_EM_RESTART': '1', 22:04:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:04:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:04:34 INFO - 'PWD': '/builds/slave/test-pgo', 22:04:34 INFO - 'SHELL': '/bin/bash', 22:04:34 INFO - 'SHLVL': '1', 22:04:34 INFO - 'TERM': 'linux', 22:04:34 INFO - 'TMOUT': '86400', 22:04:34 INFO - 'USER': 'cltbld', 22:04:34 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1454302271.423393-2069714738', 22:04:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:04:34 INFO - '_': '/tools/buildbot/bin/python'} 22:04:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:04:34 INFO - Downloading/unpacking flake8 22:04:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:04:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:04:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:04:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:04:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:04:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:04:36 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:04:36 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:04: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:04: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:04: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:04: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:04: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:04: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:04:36 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:04:36 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:04: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:04: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:04: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:04: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:04: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:04: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:04:36 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:04: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:04: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:04: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:04: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:04: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:04: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:04:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:04:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:04:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:04:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:04:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:04:37 INFO - no previously-included directories found matching 'docs/_build' 22:04:37 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:04:37 INFO - Running setup.py install for pep8 22:04:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:04:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:04:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:04:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:04:37 INFO - no previously-included directories found matching 'docs/_build' 22:04:37 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:04:37 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:04:37 INFO - Cleaning up... 22:04:37 INFO - Return code: 0 22:04:37 INFO - Running post-action listener: _resource_record_post_action 22:04:37 INFO - Running post-action listener: _start_resource_monitoring 22:04:37 INFO - Starting resource monitoring. 22:04:37 INFO - ##### 22:04:37 INFO - ##### Running install step. 22:04:37 INFO - ##### 22:04:37 INFO - Running pre-action listener: _resource_record_pre_action 22:04:37 INFO - Running main action method: install 22:04:37 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:04:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:04:37 INFO - Reading from file tmpfile_stdout 22:04:37 INFO - Detecting whether we're running mozinstall >=1.0... 22:04:37 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:04:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:04:37 INFO - Reading from file tmpfile_stdout 22:04:37 INFO - Output received: 22:04:37 INFO - Usage: mozinstall [options] installer 22:04:37 INFO - Options: 22:04:37 INFO - -h, --help show this help message and exit 22:04:37 INFO - -d DEST, --destination=DEST 22:04:37 INFO - Directory to install application into. [default: 22:04:37 INFO - "/builds/slave/test-pgo"] 22:04:37 INFO - --app=APP Application being installed. [default: firefox] 22:04:37 INFO - mkdir: /builds/slave/test-pgo/build/application 22:04:37 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:04:37 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:04:53 INFO - Reading from file tmpfile_stdout 22:04:53 INFO - Output received: 22:04:53 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:04:53 INFO - Running post-action listener: _resource_record_post_action 22:04:53 INFO - ##### 22:04:53 INFO - ##### Running run-tests step. 22:04:53 INFO - ##### 22:04:53 INFO - Running pre-action listener: _resource_record_pre_action 22:04:53 INFO - Running main action method: run_tests 22:04:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:04:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:04:53 INFO - Python 2.7.3 22:04:53 INFO - Return code: 0 22:04:53 INFO - grabbing minidump binary from tooltool 22:04:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:53 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 0x1c777f0>, '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 0x1be32d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be3760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:04:53 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:04:53 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:04:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:04:53 INFO - Return code: 0 22:04:53 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:04:53 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:04:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:04:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:04:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:04:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:04:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:04:54 INFO - Return code: 0 22:04:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SaYEH2gJQZWugE5-HzWKXA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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:04:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SaYEH2gJQZWugE5-HzWKXA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --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:04:54 INFO - Using env: {'DISPLAY': ':0', 22:04:54 INFO - 'HOME': '/home/cltbld', 22:04:54 INFO - 'LANG': 'en_US.UTF-8', 22:04:54 INFO - 'LANGUAGE': 'en_US:en', 22:04:54 INFO - 'LOGNAME': 'cltbld', 22:04:54 INFO - 'MAIL': '/var/mail/cltbld', 22:04:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:04:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:04:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:04:54 INFO - 'MOZ_NO_REMOTE': '1', 22:04:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:04:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:04:54 INFO - 'NO_EM_RESTART': '1', 22:04:54 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:04:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:04:54 INFO - 'PWD': '/builds/slave/test-pgo', 22:04:54 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:04:54 INFO - 'SHELL': '/bin/bash', 22:04:54 INFO - 'SHLVL': '1', 22:04:54 INFO - 'TERM': 'linux', 22:04:54 INFO - 'TMOUT': '86400', 22:04:54 INFO - 'USER': 'cltbld', 22:04:54 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1454302271.423393-2069714738', 22:04:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:04:54 INFO - '_': '/tools/buildbot/bin/python'} 22:04:54 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SaYEH2gJQZWugE5-HzWKXA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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:04:55 INFO - mozversion application_buildid: 20160131193211 22:04:55 INFO - mozversion application_changeset: bc49d41bd748ff4d86eb027b2a53c1eb8cecae8c 22:04:55 INFO - mozversion application_display_name: Nightly 22:04:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:04:55 INFO - mozversion application_name: Firefox 22:04:55 INFO - mozversion application_remotingname: firefox 22:04:55 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:04:55 INFO - mozversion application_vendor: Mozilla 22:04:55 INFO - mozversion application_version: 47.0a1 22:04:55 INFO - mozversion platform_buildid: 20160131193211 22:04:55 INFO - mozversion platform_changeset: bc49d41bd748ff4d86eb027b2a53c1eb8cecae8c 22:04:55 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:04:55 INFO - mozversion platform_version: 47.0a1 22:04:55 INFO - using testdate: 1454306695 22:04:55 INFO - actual date: 1454306695 22:04:55 INFO - starting webserver on 'localhost:49580' 22:04:55 INFO - SUITE-START | Running 2 tests 22:04:55 INFO - TEST-START | dromaeo_css 22:04:55 INFO - operating with platform_type : linux_ 22:04:55 INFO - Initialising browser for dromaeo_css test... 22:04:55 INFO - TEST-INFO | started process 26761 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmvtzZ5/profile http://localhost:49580/getInfo.html) 22:04:55 INFO - PROCESS | 26761 | JavaScript warning: resource://gre/modules/AddonManager.jsm, line 692: Proxy.create and Proxy.createFunction are deprecated, use new Proxy instead 22:04:59 INFO - PROCESS | 26761 | __metrics Screen width/height:1600/1200 22:04:59 INFO - PROCESS | 26761 | colorDepth:24 22:04:59 INFO - PROCESS | 26761 | Browser inner width/height: 1024/697 22:04:59 INFO - PROCESS | 26761 | __metrics 22:04:59 INFO - PROCESS | 26761 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:04:59 INFO - PROCESS | 26761 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:05:00 INFO - TEST-INFO | 26761: exit 0 22:05:00 INFO - Browser initialized. 22:05:00 INFO - Running cycle 1/1 for dromaeo_css test... 22:05:00 INFO - TEST-INFO | started process 26856 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmvtzZ5/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:05:12 INFO - PROCESS | 26856 | RSS: Main: 149053440 22:05:12 INFO - PROCESS | 26856 | 22:06:04 INFO - PROCESS | 26856 | 1454306764290 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:08:12 INFO - PROCESS | 26856 | Cycle 1(1): loaded http://localhost:49580/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49580/tests/dromaeo/cssquery-ext.html) 22:08:13 INFO - PROCESS | 26856 | RSS: Main: 269901824 22:08:13 INFO - PROCESS | 26856 | 22:11:16 INFO - PROCESS | 26856 | Cycle 1(1): loaded http://localhost:49580/tests/dromaeo/cssquery-ext.html (next: http://localhost:49580/tests/dromaeo/cssquery-jquery.html) 22:11:16 INFO - PROCESS | 26856 | RSS: Main: 234917888 22:11:16 INFO - PROCESS | 26856 | 22:14:18 INFO - PROCESS | 26856 | Cycle 1(1): loaded http://localhost:49580/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49580/tests/dromaeo/cssquery-mootools.html) 22:14:19 INFO - PROCESS | 26856 | RSS: Main: 234225664 22:14:19 INFO - PROCESS | 26856 | 22:17:21 INFO - PROCESS | 26856 | Cycle 1(1): loaded http://localhost:49580/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49580/tests/dromaeo/cssquery-prototype.html) 22:17:21 INFO - PROCESS | 26856 | RSS: Main: 213020672 22:17:21 INFO - PROCESS | 26856 | 22:20:24 INFO - PROCESS | 26856 | Cycle 1(1): loaded http://localhost:49580/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49580/tests/dromaeo/cssquery-yui.html) 22:20:25 INFO - PROCESS | 26856 | RSS: Main: 219115520 22:20:25 INFO - PROCESS | 26856 | 22:23:27 INFO - PROCESS | 26856 | Cycle 1(1): loaded http://localhost:49580/tests/dromaeo/cssquery-yui.html (next: http://localhost:49580/tests/dromaeo/cssquery-dojo.html) 22:23:28 INFO - PROCESS | 26856 | RSS: Main: 296148992 22:23:28 INFO - PROCESS | 26856 | 22:23:28 INFO - PROCESS | 26856 | __start_tp_report 22:23:28 INFO - PROCESS | 26856 | _x_x_mozilla_page_load 22:23:28 INFO - PROCESS | 26856 | _x_x_mozilla_page_load_details 22:23:28 INFO - PROCESS | 26856 | |i|pagename|runs| 22:23:28 INFO - PROCESS | 26856 | |0;dojo.html;3066.7086626770456;3142.9528557071662;3165.79422337548;3174.8888788892395;3207.102011436797;4991.42598601161;5065.240213967907;5176.741162941852;5188.974055129724;5232.372115346159;5062.974685126569;5067.214581739836;5097.796088156479;5101.821436249732;5129.435762066179;4535.614472769818;4634.675572709912;4636.35091087248;4643.177882635467;4782.641301902354;4799.784009719554;4822.252550854606;4850.830220942268;4872.147374209517;4878.463369029421;4606.97696511517;4657.604103651211;4699.929501057487;4756.66703330767;4812.37439132914;4711.0342379812055;4720.150372932871;4723.976380118112;4755.310479980418;4792.137415265286;4695.037517308978;4713.245880659112;4722.409698787652;4727.338172655831;4768.141734487791;4931.087748766489;5013.724245166514;5027.723475208899;5031.823886164003;5123.487651234884;5454.699991500466;5456.427075157131;5465.398806131322;5468.070428027245;5512.614117011811;5438.211459338413;5499.450054994469;5503.6147469677135;5504.4495550445035;5516.668999860021;5087.135187018216;5158.071547121516;5164.793408263665;5266.131088370453;5287.9735601321745;5663.1505274208375;5673.205751194836;5683.573731970118;5684.431556844283;5703.828885133453;5442.047641662693;5448.782048718086;5451.291332126798;5451.373092094381;5473.425290344536;5339.41266460689;5422.53908417781;5463.289772329572;5545.973994810973;5570.025245582007;5462.20797984298;5478.534324582455;5506.724663766796;5508.944910550923;5518.889622207534;5241.868953276198;5496.148097044965;5503.587230957694;5511.3075973772175;5514.889702205934;4284.421603083544;4297.57024297574;4318.244307246219;4370.912581748347;4379.364992076131;3809.4857194278416;3819.6371344722206;3833.4058220975794;3853;3853.8843834685003;5142.665726727751;5163.586913046947;5164;5164.535191832753;5165.811863271469;5357.678539287655;5443.020256353815;5459.918101228484;5507.146392309119;5568.387477377485;5089.109405853961;5091.694498330112;5091.9236211456855;5095.414027386824;5130.4356520782685;4591.219492686251;4669.620611973933;4673.158831410379;4675.696079754805;4690.624750019991;5704.800331988444;5729.341125770589;5753.194552762617;5778.306603207642;5801.564882633735;5516.089845175501;5516.668999860021;5518;5518.558515318685;5521.116621340566;5600.467955544217;5686.545076393962;5751.396103409249;5754.539636829128;5761.279840019997;5403.4326395727885;5435.157550579508;5514.80698175562;5547.722613869371;5549.084401073777;5522.30971128609;5526.668399896019;5548.500634942875;5575.553955683455;5586.636868603528;5427.701476418835;5469.808556700496;5481.972590137183;5482.753276102505;5523.25436066142;5286.259923610621;5314.840554783363;5349.358077030781;5393.730313484231;5411.594130440311;5259.868503287448;5272.209168624737;5286.550643195372;5293.523582877559;5294.179402192666;5367.329083864517;5374.193870919394;5388.488093631099;5394.865128371822;5433.347998240237;5157.7679004444135;5225;5241;5270.23581580661;5355.116405793156 22:23:28 INFO - PROCESS | 26856 | |1;ext.html;524.4650456534335;531.5322516185756;531.5588061908617;580.9128630705391;629.8834715577618;30127.24681882954;36285.637143628555;36684.99999999996;36761.816190919075;36845.26309473809;38836.22327553454;39213.41179882304;39250.41124383137;39256.41115383271;39318.21363572727;8424.747257582267;8654.307655387554;8660.783480413009;8667.95666021669;8678.956605216965;8510.106438823927;8662.87005694915;8668.826623467527;8669.739907802776;8675.739727808175;8615.65537378504;8704.825903481926;8709.95645021774;8716.302695784354;8718.258947989429;8624.741257762245;8706.521141337224;8713.04156542783;8717.128287171296;8718.128187181295;8493.108223636553;8524;8567.186117318844;8587.828243435159;8595.871061934076;38939;38947.61052389497;39111.21777564433;39488;39591;3211.405889910374;3256.902292931216;3265.7224135948472;3829.1384438501113;4135.255653982282;29560.70439295601;30004.649790759468;30556.54165187524;30931.536026959613;30966.53550196749;3894.883153505399;3921.745086569364;3935.3900145477496;4031.093004074089;4115.58844115589;252027;252447.73776131184;253118;253155;254598;51120.488795111574;52282.73858630683;58990.70504647449;60019.298166674096;60112;52920.73539632277;52969.2054619181;53042.46957530452;53127.20309195365;53146.468535314925;14485.85514144845;14772;15245.847541524443;15415.229238538028;15465.149416782186;11976.443062401831;12151.513939442324;12189.695257618454;12190.39048047594;12199.329036903055;18382.908085459487;18566.164522596515;19230.519237018907;19239.921612541926;19488.220471181277;6965.721371145098;7211.350978411968;7242.891356629655;7264.309890560388;7266.818329541804;940.8729821474013;967.1827305926481;1053.4995876958383;1064.350746044912;1069.1446842525947;28007;28123.859380702965;28322.291942701184;28366.71633283682;28612.427751444855;1033.612395351743;1040.0587468341164;1040.1210976724656;1046.56567524478;1052.353067449439;13002.804957925639;13637.659058523417;13668.52160174389;15051.473198438001;15247.542573722585;293334;295638;297526;297731;298911;51750.741246293524;51920.74039629778;52072.21891671628;52123.739381302854;52153;1194.778965891313;1264.8166015927638;1295.0934345957867;1373.3064802274987;1389.6595334142999;25372.701548798537;25449.236522904343;26381.736182637927;28881.277968050967;29543.409131817672;43351.78324108359;43534.78232608816;43647.78176109099;43698.56301436945;43842.780786095864;280921;290395;291025;348906;355130;27936.161915142577;28008.43983120367;28095.578566321932;28117.43765124727;28211.294717632223;42966;44044.77977610091;44119.33820992624;45009;45130.77434612806;36573;36718.44922326221;37421.81289093537;37450.250994980495;38172;37312.493758114884;37513.81243093767;38034.429483557215;38050.61949380582;38245.80877095597;35807.82096089503;36084.27831443304;36309.27381452409;36522.26955460929;36629.26741465209;32390.514142287415;33315.500267495525;33515.497267540515;33586.664133358354;33841;25449.363765906;25476.363090922874;25541.744582553936;25564.74435255698;25793 22:23:28 INFO - PROCESS | 26856 | |2;jquery.html;361.6528132992329;363.4820380957136;367.06215619093217;368.81006281764894;371.747211895911;13583.932080339584;13694.959155210187;16100.35598576057;16479.176041197938;17192.570185745364;15203.467878624251;15574.053243344582;16052.518424447257;16061.277242524086;16149.515514534552;5108.923366149511;5259.474052594729;5260.184671375943;5260.815871444481;5260.947390526103;3958.6437220650137;4108.609682080198;5235.73821308933;5293.814716484924;5740.512056475184;5847.386024467433;5891.381404952483;5935.614185077978;5944.346121926606;5952.613080149798;5714.828555143332;5809.73856176471;5813.47678708914;5813.82558523245;5831.03787874998;5016.3980322361185;5032.47159048302;5069.340985671839;5161.8193363232485;5171.120909445403;19705.31031413908;19820.30628927995;19853.50366240841;20158.79841201584;20385.08267127983;2282.8173746100274;2329.6738456616085;2388.868612226327;2417.2443414507475;2794.9441011179865;9117.726468205965;12990;12991.155574887602;13013.804792928113;13368.264745438997;1763.0920076160787;1843.935462258828;1844.7786265648074;1861.7486639303656;1931.7392152059433;56484.71757641186;58805;60682;60782.696086519725;61348.705590608675;10121.797564048678;10223.079922806983;10250.436226007641;10251.794964100676;10299.742506437398;12624.873751262554;13658.453661853613;13675.974301927396;13700.3834827433;13729.28383952006;7212.954121652331;7416.214387694687;7680.34717049046;7730.690772369155;7751.496152750054;7445.292697193758;7469.551826890295;7474;7516.173220945691;7531.133919599207;4480.193565158303;4494.662900282492;4503.3245013247615;4526.298423744325;4548.840790572314;1694.4238958754083;1770.7166853303668;1791.1313013188594;1820.8270214329618;1850.3246315094893;901.2609660078673;911.2300106410073;927.2859897878595;965.7537327981461;1002.0981116994762;15332.156731379659;15598.376064957274;15834.920825395799;15986.520404387888;16933.83066169347;875.7591662292921;898.2275243290765;962.2398305338844;967.8257913575624;1014.3102690170607;8719.476831390137;9184.403013804082;9217.216536594464;9803.264755143251;9832.115109640166;349910;524159;525713;559730;572137.2786272167;61840;62017;63074.68462657657;64004.35995639984;75844.24155758483;1153.700037990112;1175.1304035014027;1180.9822852657217;1192.5170306026073;1193.9880601193877;11274.943625281821;14221.360038798071;14789;14869.182194978946;15350.385984560493;31489.527657084705;32629.510557341186;33014.50478242876;34175;34539.4819077709;37325.253494929406;42770.14459710726;45346.31980520361;48932.266016009075;49406.25890611572;7380.261973802577;7396.740132447631;7427.554346739213;7829.256220659028;8002.599870006593;9543.761405964906;11754.177207595387;11974.880251197377;12033.097517686034;12081.939590301992;9878.555465004236;9937.701868943943;10183.592656293666;10351.585936562453;10465.47672616351;9964.202863771026;10162.23783216247;10292.433916134685;10349.9482502587;10496.405818486259;10179.592816287266;10410;10449.164066874784;10489.29603102374;10562.31344962575;7625.961870190614;7773.650185741768;7786.61066946639;7836.138024817379;7877.8818317724135;8866.866996995179;10574.8413773795;10620.20348473883;10682.89317106819;10872.782544348911 22:23:28 INFO - PROCESS | 26856 | |3;mootools.html;1300.1224173682774;1457.1912588513374;1468.8237411510618;1625.3092435714825;1777.4312220089575;6866.725330986761;7464.813379665511;7619.352355049814;7657.081150261976;7667.769966901002;7539;7730.072391313036;7742.961285193566;7750.457467977244;7751.534907905516;1973.733545971297;2026.625074361248;2216.5345277491747;2232.073689418889;2244.124791331382;2276.157821606008;2281.7376001759844;2284.851484653492;2287.8970446329954;2292.484191057007;2192.1888901106613;2265.694131292271;2272.6022945984387;2275.6358982562792;2275.681404603357;2209.834262430316;2240.0591751464344;2241.5628952354214;2296.632538793785;2298.344971683079;2235.653473711577;2253.7182852143483;2264.2867496738477;2268.0700912625907;2275.249167774647;7770.49491783038;7806.609669516558;7809;7841.568713720743;7848.489848159851;4550.340200670884;4591.816327346902;4639;4640.09518143962;4644.256918892961;3030.1515575638855;3083.1521331633758;3116.532520121977;3134.576832127679;3182.809031458097;923.0446487885074;939.0843927171022;942.180303136269;964.6189755046787;1014.1987829614669;10147.137493313077;10308.484575771181;10333.276670633059;10344.32761870476;10357.63748268807;3941.8620348287673;4046.9392959105635;4124.896877578085;4128.649064829523;4141.047559061432;8563.743087707378;8733.297007083685;8756.080611535697;8763.123687631314;8770.956145219234;4738.976305118521;4745.454272758608;4763.76181190939;4765.571098601074;4768.189407800683;4368.803403846835;4405.052913623522;4410.691251612357;4412.161689279027;4417.160739459492;3190.090824115116;3214.083986064007;3291.3581851539197;3355.9496607550905;3468.3063387322636;974.571188676994;1011.2920955331298;1015.6140666546665;1016.5577973581516;1018.5721996761378;1253.2417887178308;1269.650846017334;1286.948522059126;1312.3831799054428;1322.702391961801;7049.647517624201;7049.8237544060785;7308.926910730931;7485.513441626277;7488.700451981968;1093.8632670916136;1100.6422912553453;1113.1095123900848;1122.9775404491863;1128.7234627516148;5742.368339482737;5807.709614519257;5808.128780682931;5815.069588865761;5816.88366232673;9095.954520227357;9152.725418237464;9338.299627527962;9371.859422108673;9470.621175152917;9494.810103798023;9518.381305215138;9616.567254473426;9628.229741620653;9633.951830240943;7050.400715939202;7123.643817809088;7267.745628902963;7277.563346199351;7280.817979550554;7017.614031228331;7032.578045317093;7036.718531258693;7038.225795162631;7041.929580704127;7932;8188;8268.462549934235;8379.832403351777;8407.53758543286;8370.869932559026;8439.535825529654;8556.058833528183;8559;8570.657173712982;6726.6636668167375;6940;6955.061066755923;6980.267071957372;6988.685509151998;6606.735730570916;6731.461483081243;7164.677589508589;7450.180480147071;7461.888071678821;6574.940341277853;6809.965950170217;6934.133233345832;6968.581885086911;7123.430125590044;6817.147856517935;6846.315368463114;6925.826854328682;6952.339527744856;7076.964615176891;6461.06314584392;6509.576877502947;6510.772122975863;6512.3162067982175;6515.218173819172;6012.188354572077;6051.33435322123;6084.756609735561;6138.846528836815;6154.907676384947;6163.84590385244;6185.134081228722;6194.969025154845;6200.193974783249;6238.500919926486 22:23:28 INFO - PROCESS | 26856 | |4;prototype.html;343.56710544713656;349.90902365384994;350.1543771791124;357.47451246667424;362.3097998313214;5643.125315576092;5755.050416681248;5761.510271626907;5766.538676905848;5845.912311315328;5619.7471113799875;5738.368779434259;5739.167820666001;5762.683052432115;5782.855428614287;4554.908901821962;4561.133384656921;4565.949831538748;4569.565891240343;4573.885652858672;4287.378330142127;4411.911761764763;4436.334549817537;4534.206513860077;4559.544045595447;4483.282674772037;4485.775711214426;4496.4829044659955;4497.123061003105;4500.932486012713;4465.955340446602;4486.663500237479;4500.369948207221;4508.5266047064915;4540.72755634663;4020.597940205956;4028.6777057835598;4036.7577945323374;4037.0916543777416;4042.0299128209017;5373.892522149574;5508.944910550883;5537.141743029837;5554.166874968787;5562.054450743383;5172.327597412313;5174.534291913746;5177.430482646906;5178;5179.352580927384;5879.206307148523;6217.533684973645;6224.159738435299;6228.003519436868;6231.6572588507615;4241.278982572939;4286.57134286572;4389.429374181368;4390.495093064306;4390.582894625006;6410.647414392207;6448.322926092739;6476.093346931433;6477.417032467053;6499.447546958514;4482.350059241392;4483.641308695296;4484.080763443486;4484.9103017940115;4493.820247190141;4456.108778244364;4493.955060449419;4543.182227199136;4547.431571053618;4550.0217453247715;5174.197999310113;5195.792168313225;5196.870078247998;5197.66215196011;5211.348581427322;6213;6213.906791398133;6217.813465596039;6220.875582488325;6225.221847269091;1578.6369135098992;1602.2149146917927;1608.9115098669452;1610.4604957339188;1611.1460925709393;1069.2141276162015;1082.1126676125502;1090.3076546393097;1091.8198497247865;1099.587654629514;5869.765209391577;5871.9706401468575;5874.030784920526;5884.411558844167;5907.084401917709;6384.553081284265;6385.96807015962;6387.105805187278;6401.263854656681;6403.903941440882;5929.229200204032;5959.702014899238;5960.344362120163;5979.431953964367;5980.760769569256;3332.683395077464;3396.881109161217;3429.605595356566;3444.6727560881677;3446.551948246712;6634.601923884582;6647.202335719745;6700.329967003261;6760.425363844129;6765.391114799691;6602.900956485657;6627.668616569249;6643.036759669821;6643.50173736962;6651.301613330531;6587.73649054042;6692.263850976388;6696.665166741644;6704.9607310866895;6722.327767223239;6164.921138800782;6325.399087086719;6422.678866056772;6438.356164383524;6438.742450301936;6231.9688401557705;6360.459360954371;6374.1394911688185;6381.3937675920715;6395.648239346694;6672.633005184762;6698.363655452724;6700.631465269262;6709.832254193684;6715.764948226789;4530.728156310632;4575.885602859955;4618.491965883817;4620.330052142488;4628.930566041579;6350.587211831216;6352.174217351715;6353.364663533795;6354.618722876642;6356.459700925288;6187.628742275478;6188.938110618837;6193.566450348432;6193.721282542207;6201.472874805511;6053.213082299273;6178.764247150498;6190.102435146969;6194.473469755121;6194.969025154845;6070.18052562916;6075.756969721162;6076.270847498328;6084.087386892002;6086.147939288415;6177.227846519185;6210.503159747119;6210.968945155245;6221.502279817694;6222.253329600477;5955.344912059583;6069.180660610761;6075.149479073022;6080.300765412034;6080.604760690541 22:23:28 INFO - PROCESS | 26856 | |5;yui.html;685.4208194076004;794.6636887550602;817.0971076959959;818.529345626265;822.0135836995606;13927.930360348197;14032.64918377041;14061.859381406182;14068.085574437668;14147.929260353696;12924.676883077927;14153.22157281349;14519.564413067625;14571.708565828703;14582.375172468952;662.092932682226;676.7665155521362;792.5878543157554;804.8752443371287;808.1231863428187;784.1022029775903;785.458033956571;791.6674996501455;792;796.7052190689453;845.4293351987415;846.7459762071354;847.4364547575885;847.4406891451644;847.5677404523676;680.7889554238202;698.5564166754123;825.3232349473434;844.0883845446903;844.6832437835811;619.5136817598209;620.1658768955747;620.7020630097534;622.1072760588524;622.5704264057786;13250.86749132506;13279.402426890812;13341.86658133416;13364.264965426897;13396.732065358736;12289.56986505477;12358.196717213352;12442.751144977141;12492.500299987989;12765.489380424771;10605.363678179334;10622.840657390145;10747.516361763739;11597.4201289936;11750.294982301004;4358.150160718661;4394.8901277468;4509.977450112761;4530.1392735380505;4548.5906268436;45676;46164.53835461636;46566.53433465656;46653;46703.29945050827;9761.73745770222;10130.290879638354;10139.239557033105;10190.337628054152;10391.584336626602;18062.63874722498;18119.547011324557;18120.365787197385;18350.082495875155;18404.907975460304;7375.373093287023;7615.581143037186;7665.540067595962;7839;7853.646585903648;4286.37847512109;4319.697621166488;4322.740635561876;4373.1472362888935;4491.191585514639;3197.7441804655573;3210.470272405027;3219.4848824188016;3240.1089700332595;3245.8052516849066;587.224863180606;606.5875204860737;618.4959258204549;656.9080328753978;679.6092246958019;645.3514218210762;662.5730414974764;669.5112567825514;682.8634273145292;690.1580072311772;7759.469441404148;8161.79595510117;8301.584920753938;8406.747797566082;8436.704715334934;571.4428432278495;593.8283558005049;636.8789929913302;641.4611726150056;658.6542065415599;3770.1140232045445;3810.237952409529;3860.401637746154;3966.8413263469715;3977.801109944491;50175;50813.74593127011;51000.74499627478;51243.7437812816;51474.74262628663;43571.56428435739;43865.78067109644;44546.77726611346;47212.7639361801;47869.28196077062;40248.396274055915;40886.1822763549;43369;43380.78309608432;43879;7669.769906902802;7741.806454838674;7827.608619568885;7835.647395867314;7878.448508604342;32474.35051299008;32488.51267230946;32977.67022329746;33174;33338.166545836546;39218.80390598029;41359.37960930649;42173;42926.78536607297;42934.141317172856;10573.2598718089;10663.680089597325;10734.087602553558;10793.352398856094;10916.727081823017;11160.33038017689;11409.087273018305;11413.771724565297;11434.48544815502;11916.285022898654;9460.95269523648;9843.85234221473;10241.487925603838;10258.743531411774;10417.84373234387;10161.695149145242;10846.620368287073;10881.748598911227;11189.21675482741;11279.887201127884;9887.901120988698;9944.204463643036;10121.765223137105;10196.286259961731;10247.7438064049;8719.91280087191;8974.461532308082;9046.638134474548;9238.491882946502;9293.535323233946;8075.555844428378;8498.447600905922;8663.176998185163;9027.187553120251;9141.542922853963 22:23:28 INFO - PROCESS | 26856 | __end_tp_report 22:23:28 INFO - PROCESS | 26856 | __start_cc_report 22:23:28 INFO - PROCESS | 26856 | _x_x_mozilla_cycle_collect,938 22:23:28 INFO - PROCESS | 26856 | __end_cc_report 22:23:28 INFO - PROCESS | 26856 | __startTimestamp1454307808240__endTimestamp 22:23:28 INFO - PROCESS | 26856 | 22:23:28 INFO - PROCESS | 26856 | ------- Summary: start ------- 22:23:28 INFO - PROCESS | 26856 | Number of tests: 6 22:23:28 INFO - PROCESS | 26856 | 22:23:28 INFO - PROCESS | 26856 | [#0] dojo.html Cycles:165 Average:5124.20 Median:5286.55 stddev:550.60 (10.4%) stddev-sans-first:528.10 22:23:28 INFO - PROCESS | 26856 | Values: 3066.7 3143.0 3165.8 3174.9 3207.1 4991.4 5065.2 5176.7 5189.0 5232.4 5063.0 5067.2 5097.8 5101.8 5129.4 4535.6 4634.7 4636.4 4643.2 4782.6 4799.8 4822.3 4850.8 4872.1 4878.5 4607.0 4657.6 4699.9 4756.7 4812.4 4711.0 4720.2 4724.0 4755.3 4792.1 4695.0 4713.2 4722.4 4727.3 4768.1 4931.1 5013.7 5027.7 5031.8 5123.5 5454.7 5456.4 5465.4 5468.1 5512.6 5438.2 5499.5 5503.6 5504.4 5516.7 5087.1 5158.1 5164.8 5266.1 5288.0 5663.2 5673.2 5683.6 5684.4 5703.8 5442.0 5448.8 5451.3 5451.4 5473.4 5339.4 5422.5 5463.3 5546.0 5570.0 5462.2 5478.5 5506.7 5508.9 5518.9 5241.9 5496.1 5503.6 5511.3 5514.9 4284.4 4297.6 4318.2 4370.9 4379.4 3809.5 3819.6 3833.4 3853.0 3853.9 5142.7 5163.6 5164.0 5164.5 5165.8 5357.7 5443.0 5459.9 5507.1 5568.4 5089.1 5091.7 5091.9 5095.4 5130.4 4591.2 4669.6 4673.2 4675.7 4690.6 5704.8 5729.3 5753.2 5778.3 5801.6 5516.1 5516.7 5518.0 5518.6 5521.1 5600.5 5686.5 5751.4 5754.5 5761.3 5403.4 5435.2 5514.8 5547.7 5549.1 5522.3 5526.7 5548.5 5575.6 5586.6 5427.7 5469.8 5482.0 5482.8 5523.3 5286.3 5314.8 5349.4 5393.7 5411.6 5259.9 5272.2 5286.6 5293.5 5294.2 5367.3 5374.2 5388.5 5394.9 5433.3 5157.8 5225.0 5241.0 5270.2 5355.1 22:23:28 INFO - PROCESS | 26856 | 22:23:28 INFO - PROCESS | 26856 | [#1] ext.html Cycles:180 Average:45345.29 Median:36740.13 stddev:75604.56 (205.8%) stddev-sans-first:75741.75 22:23:28 INFO - PROCESS | 26856 | Values: 524.5 531.5 531.6 580.9 629.9 30127.2 36285.6 36685.0 36761.8 36845.3 38836.2 39213.4 39250.4 39256.4 39318.2 8424.7 8654.3 8660.8 8668.0 8679.0 8510.1 8662.9 8668.8 8669.7 8675.7 8615.7 8704.8 8710.0 8716.3 8718.3 8624.7 8706.5 8713.0 8717.1 8718.1 8493.1 8524.0 8567.2 8587.8 8595.9 38939.0 38947.6 39111.2 39488.0 39591.0 3211.4 3256.9 3265.7 3829.1 4135.3 29560.7 30004.6 30556.5 30931.5 30966.5 3894.9 3921.7 3935.4 4031.1 4115.6 252027.0 252447.7 253118.0 253155.0 254598.0 51120.5 52282.7 58990.7 60019.3 60112.0 52920.7 52969.2 53042.5 53127.2 53146.5 14485.9 14772.0 15245.8 15415.2 15465.1 11976.4 12151.5 12189.7 12190.4 12199.3 18382.9 18566.2 19230.5 19239.9 19488.2 6965.7 7211.4 7242.9 7264.3 7266.8 940.9 967.2 1053.5 1064.4 1069.1 28007.0 28123.9 28322.3 28366.7 28612.4 1033.6 1040.1 1040.1 1046.6 1052.4 13002.8 13637.7 13668.5 15051.5 15247.5 293334.0 295638.0 297526.0 297731.0 298911.0 51750.7 51920.7 52072.2 52123.7 52153.0 1194.8 1264.8 1295.1 1373.3 1389.7 25372.7 25449.2 26381.7 28881.3 29543.4 43351.8 43534.8 43647.8 43698.6 43842.8 280921.0 290395.0 291025.0 348906.0 355130.0 27936.2 28008.4 28095.6 28117.4 28211.3 42966.0 44044.8 44119.3 45009.0 45130.8 36573.0 36718.4 37421.8 37450.3 38172.0 37312.5 37513.8 38034.4 38050.6 38245.8 35807.8 36084.3 36309.3 36522.3 36629.3 32390.5 33315.5 33515.5 33586.7 33841.0 25449.4 25476.4 25541.7 25564.7 25793.0 22:23:28 INFO - PROCESS | 26856 | 22:23:28 INFO - PROCESS | 26856 | [#2] jquery.html Cycles:180 Average:26661.50 Median:370.28 stddev:83744.95 (22616.7%) stddev-sans-first:83956.59 22:23:28 INFO - PROCESS | 26856 | Values: 361.7 363.5 367.1 368.8 371.7 13583.9 13695.0 16100.4 16479.2 17192.6 15203.5 15574.1 16052.5 16061.3 16149.5 5108.9 5259.5 5260.2 5260.8 5260.9 3958.6 4108.6 5235.7 5293.8 5740.5 5847.4 5891.4 5935.6 5944.3 5952.6 5714.8 5809.7 5813.5 5813.8 5831.0 5016.4 5032.5 5069.3 5161.8 5171.1 19705.3 19820.3 19853.5 20158.8 20385.1 2282.8 2329.7 2388.9 2417.2 2794.9 9117.7 12990.0 12991.2 13013.8 13368.3 1763.1 1843.9 1844.8 1861.7 1931.7 56484.7 58805.0 60682.0 60782.7 61348.7 10121.8 10223.1 10250.4 10251.8 10299.7 12624.9 13658.5 13676.0 13700.4 13729.3 7213.0 7416.2 7680.3 7730.7 7751.5 7445.3 7469.6 7474.0 7516.2 7531.1 4480.2 4494.7 4503.3 4526.3 4548.8 1694.4 1770.7 1791.1 1820.8 1850.3 901.3 911.2 927.3 965.8 1002.1 15332.2 15598.4 15834.9 15986.5 16933.8 875.8 898.2 962.2 967.8 1014.3 8719.5 9184.4 9217.2 9803.3 9832.1 349910.0 524159.0 525713.0 559730.0 572137.3 61840.0 62017.0 63074.7 64004.4 75844.2 1153.7 1175.1 1181.0 1192.5 1194.0 11274.9 14221.4 14789.0 14869.2 15350.4 31489.5 32629.5 33014.5 34175.0 34539.5 37325.3 42770.1 45346.3 48932.3 49406.3 7380.3 7396.7 7427.6 7829.3 8002.6 9543.8 11754.2 11974.9 12033.1 12081.9 9878.6 9937.7 10183.6 10351.6 10465.5 9964.2 10162.2 10292.4 10349.9 10496.4 10179.6 10410.0 10449.2 10489.3 10562.3 7626.0 7773.7 7786.6 7836.1 7877.9 8866.9 10574.8 10620.2 10682.9 10872.8 22:23:28 INFO - PROCESS | 26856 | 22:23:28 INFO - PROCESS | 26856 | [#3] mootools.html Cycles:180 Average:5356.62 Median:6174.49 stddev:2772.80 (44.9%) stddev-sans-first:2763.81 22:23:28 INFO - PROCESS | 26856 | Values: 1300.1 1457.2 1468.8 1625.3 1777.4 6866.7 7464.8 7619.4 7657.1 7667.8 7539.0 7730.1 7743.0 7750.5 7751.5 1973.7 2026.6 2216.5 2232.1 2244.1 2276.2 2281.7 2284.9 2287.9 2292.5 2192.2 2265.7 2272.6 2275.6 2275.7 2209.8 2240.1 2241.6 2296.6 2298.3 2235.7 2253.7 2264.3 2268.1 2275.2 7770.5 7806.6 7809.0 7841.6 7848.5 4550.3 4591.8 4639.0 4640.1 4644.3 3030.2 3083.2 3116.5 3134.6 3182.8 923.0 939.1 942.2 964.6 1014.2 10147.1 10308.5 10333.3 10344.3 10357.6 3941.9 4046.9 4124.9 4128.6 4141.0 8563.7 8733.3 8756.1 8763.1 8771.0 4739.0 4745.5 4763.8 4765.6 4768.2 4368.8 4405.1 4410.7 4412.2 4417.2 3190.1 3214.1 3291.4 3355.9 3468.3 974.6 1011.3 1015.6 1016.6 1018.6 1253.2 1269.7 1286.9 1312.4 1322.7 7049.6 7049.8 7308.9 7485.5 7488.7 1093.9 1100.6 1113.1 1123.0 1128.7 5742.4 5807.7 5808.1 5815.1 5816.9 9096.0 9152.7 9338.3 9371.9 9470.6 9494.8 9518.4 9616.6 9628.2 9634.0 7050.4 7123.6 7267.7 7277.6 7280.8 7017.6 7032.6 7036.7 7038.2 7041.9 7932.0 8188.0 8268.5 8379.8 8407.5 8370.9 8439.5 8556.1 8559.0 8570.7 6726.7 6940.0 6955.1 6980.3 6988.7 6606.7 6731.5 7164.7 7450.2 7461.9 6574.9 6810.0 6934.1 6968.6 7123.4 6817.1 6846.3 6925.8 6952.3 7077.0 6461.1 6509.6 6510.8 6512.3 6515.2 6012.2 6051.3 6084.8 6138.8 6154.9 6163.8 6185.1 6195.0 6200.2 6238.5 22:23:28 INFO - PROCESS | 26856 | 22:23:28 INFO - PROCESS | 26856 | [#4] prototype.html Cycles:180 Average:5203.66 Median:5870.87 stddev:1549.09 (26.4%) stddev-sans-first:1509.88 22:23:28 INFO - PROCESS | 26856 | Values: 343.6 349.9 350.2 357.5 362.3 5643.1 5755.1 5761.5 5766.5 5845.9 5619.7 5738.4 5739.2 5762.7 5782.9 4554.9 4561.1 4565.9 4569.6 4573.9 4287.4 4411.9 4436.3 4534.2 4559.5 4483.3 4485.8 4496.5 4497.1 4500.9 4466.0 4486.7 4500.4 4508.5 4540.7 4020.6 4028.7 4036.8 4037.1 4042.0 5373.9 5508.9 5537.1 5554.2 5562.1 5172.3 5174.5 5177.4 5178.0 5179.4 5879.2 6217.5 6224.2 6228.0 6231.7 4241.3 4286.6 4389.4 4390.5 4390.6 6410.6 6448.3 6476.1 6477.4 6499.4 4482.4 4483.6 4484.1 4484.9 4493.8 4456.1 4494.0 4543.2 4547.4 4550.0 5174.2 5195.8 5196.9 5197.7 5211.3 6213.0 6213.9 6217.8 6220.9 6225.2 1578.6 1602.2 1608.9 1610.5 1611.1 1069.2 1082.1 1090.3 1091.8 1099.6 5869.8 5872.0 5874.0 5884.4 5907.1 6384.6 6386.0 6387.1 6401.3 6403.9 5929.2 5959.7 5960.3 5979.4 5980.8 3332.7 3396.9 3429.6 3444.7 3446.6 6634.6 6647.2 6700.3 6760.4 6765.4 6602.9 6627.7 6643.0 6643.5 6651.3 6587.7 6692.3 6696.7 6705.0 6722.3 6164.9 6325.4 6422.7 6438.4 6438.7 6232.0 6360.5 6374.1 6381.4 6395.6 6672.6 6698.4 6700.6 6709.8 6715.8 4530.7 4575.9 4618.5 4620.3 4628.9 6350.6 6352.2 6353.4 6354.6 6356.5 6187.6 6188.9 6193.6 6193.7 6201.5 6053.2 6178.8 6190.1 6194.5 6195.0 6070.2 6075.8 6076.3 6084.1 6086.1 6177.2 6210.5 6211.0 6221.5 6222.3 5955.3 6069.2 6075.1 6080.3 6080.6 22:23:28 INFO - PROCESS | 26856 | 22:23:28 INFO - PROCESS | 26856 | [#5] yui.html Cycles:180 Average:13058.19 Median:4520.06 stddev:14532.73 (321.5%) stddev-sans-first:14543.79 22:23:28 INFO - PROCESS | 26856 | Values: 685.4 794.7 817.1 818.5 822.0 13927.9 14032.6 14061.9 14068.1 14147.9 12924.7 14153.2 14519.6 14571.7 14582.4 662.1 676.8 792.6 804.9 808.1 784.1 785.5 791.7 792.0 796.7 845.4 846.7 847.4 847.4 847.6 680.8 698.6 825.3 844.1 844.7 619.5 620.2 620.7 622.1 622.6 13250.9 13279.4 13341.9 13364.3 13396.7 12289.6 12358.2 12442.8 12492.5 12765.5 10605.4 10622.8 10747.5 11597.4 11750.3 4358.2 4394.9 4510.0 4530.1 4548.6 45676.0 46164.5 46566.5 46653.0 46703.3 9761.7 10130.3 10139.2 10190.3 10391.6 18062.6 18119.5 18120.4 18350.1 18404.9 7375.4 7615.6 7665.5 7839.0 7853.6 4286.4 4319.7 4322.7 4373.1 4491.2 3197.7 3210.5 3219.5 3240.1 3245.8 587.2 606.6 618.5 656.9 679.6 645.4 662.6 669.5 682.9 690.2 7759.5 8161.8 8301.6 8406.7 8436.7 571.4 593.8 636.9 641.5 658.7 3770.1 3810.2 3860.4 3966.8 3977.8 50175.0 50813.7 51000.7 51243.7 51474.7 43571.6 43865.8 44546.8 47212.8 47869.3 40248.4 40886.2 43369.0 43380.8 43879.0 7669.8 7741.8 7827.6 7835.6 7878.4 32474.4 32488.5 32977.7 33174.0 33338.2 39218.8 41359.4 42173.0 42926.8 42934.1 10573.3 10663.7 10734.1 10793.4 10916.7 11160.3 11409.1 11413.8 11434.5 11916.3 9461.0 9843.9 10241.5 10258.7 10417.8 10161.7 10846.6 10881.7 11189.2 11279.9 9887.9 9944.2 10121.8 10196.3 10247.7 8719.9 8974.5 9046.6 9238.5 9293.5 8075.6 8498.4 8663.2 9027.2 9141.5 22:23:28 INFO - PROCESS | 26856 | -------- Summary: end -------- 22:23:28 INFO - PROCESS | 26856 | 22:23:28 INFO - TEST-INFO | 26856: exit 0 22:23:28 INFO - TEST-OK | dromaeo_css | took 1113838ms 22:23:28 INFO - TEST-START | kraken 22:23:28 INFO - operating with platform_type : linux_ 22:23:28 INFO - Initialising browser for kraken test... 22:23:28 INFO - TEST-INFO | started process 27044 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpv1sdgW/profile http://localhost:49580/getInfo.html) 22:23:29 INFO - PROCESS | 27044 | JavaScript warning: resource://gre/modules/AddonManager.jsm, line 692: Proxy.create and Proxy.createFunction are deprecated, use new Proxy instead 22:23:33 INFO - PROCESS | 27044 | __metrics Screen width/height:1600/1200 22:23:33 INFO - PROCESS | 27044 | colorDepth:24 22:23:33 INFO - PROCESS | 27044 | Browser inner width/height: 1024/697 22:23:33 INFO - PROCESS | 27044 | __metrics 22:23:33 INFO - PROCESS | 27044 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:23:33 INFO - PROCESS | 27044 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:23:34 INFO - TEST-INFO | 27044: exit 0 22:23:34 INFO - Browser initialized. 22:23:34 INFO - Running cycle 1/1 for kraken test... 22:23:34 INFO - TEST-INFO | started process 27127 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpv1sdgW/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:23:46 INFO - PROCESS | 27127 | RSS: Main: 149295104 22:23:46 INFO - PROCESS | 27127 | 22:23:48 INFO - PROCESS | 27127 | Cycle 1(1): loaded http://localhost:49580/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49580/tests/kraken/driver.html?testName=audio-beat-detection) 22:23:49 INFO - PROCESS | 27127 | RSS: Main: 190119936 22:23:49 INFO - PROCESS | 27127 | 22:23:52 INFO - PROCESS | 27127 | Cycle 1(1): loaded http://localhost:49580/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49580/tests/kraken/driver.html?testName=audio-dft) 22:23:52 INFO - PROCESS | 27127 | RSS: Main: 178974720 22:23:52 INFO - PROCESS | 27127 | 22:23:55 INFO - PROCESS | 27127 | Cycle 1(1): loaded http://localhost:49580/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49580/tests/kraken/driver.html?testName=audio-fft) 22:23:56 INFO - PROCESS | 27127 | RSS: Main: 164548608 22:23:56 INFO - PROCESS | 27127 | 22:23:58 INFO - PROCESS | 27127 | Cycle 1(1): loaded http://localhost:49580/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49580/tests/kraken/driver.html?testName=audio-oscillator) 22:23:58 INFO - PROCESS | 27127 | RSS: Main: 167464960 22:23:58 INFO - PROCESS | 27127 | 22:24:00 INFO - PROCESS | 27127 | Cycle 1(1): loaded http://localhost:49580/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49580/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:24:01 INFO - PROCESS | 27127 | RSS: Main: 167292928 22:24:01 INFO - PROCESS | 27127 | 22:24:04 INFO - PROCESS | 27127 | Cycle 1(1): loaded http://localhost:49580/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49580/tests/kraken/driver.html?testName=imaging-darkroom) 22:24:05 INFO - PROCESS | 27127 | RSS: Main: 169443328 22:24:05 INFO - PROCESS | 27127 | 22:24:08 INFO - PROCESS | 27127 | Cycle 1(1): loaded http://localhost:49580/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49580/tests/kraken/driver.html?testName=imaging-desaturate) 22:24:09 INFO - PROCESS | 27127 | RSS: Main: 169795584 22:24:09 INFO - PROCESS | 27127 | 22:24:11 INFO - PROCESS | 27127 | Cycle 1(1): loaded http://localhost:49580/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49580/tests/kraken/driver.html?testName=json-parse-financial) 22:24:12 INFO - PROCESS | 27127 | RSS: Main: 169476096 22:24:12 INFO - PROCESS | 27127 | 22:24:14 INFO - PROCESS | 27127 | Cycle 1(1): loaded http://localhost:49580/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49580/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:24:14 INFO - PROCESS | 27127 | RSS: Main: 178352128 22:24:14 INFO - PROCESS | 27127 | 22:24:16 INFO - PROCESS | 27127 | Cycle 1(1): loaded http://localhost:49580/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49580/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:24:16 INFO - PROCESS | 27127 | RSS: Main: 175890432 22:24:16 INFO - PROCESS | 27127 | 22:24:19 INFO - PROCESS | 27127 | Cycle 1(1): loaded http://localhost:49580/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49580/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:24:19 INFO - PROCESS | 27127 | RSS: Main: 188366848 22:24:19 INFO - PROCESS | 27127 | 22:24:22 INFO - PROCESS | 27127 | Cycle 1(1): loaded http://localhost:49580/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49580/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:24:22 INFO - PROCESS | 27127 | RSS: Main: 192602112 22:24:22 INFO - PROCESS | 27127 | 22:24:25 INFO - PROCESS | 27127 | Cycle 1(1): loaded http://localhost:49580/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49580/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:24:25 INFO - PROCESS | 27127 | RSS: Main: 192212992 22:24:25 INFO - PROCESS | 27127 | 22:24:27 INFO - PROCESS | 27127 | Cycle 1(1): loaded http://localhost:49580/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49580/tests/kraken/driver.html?testName=ai-astar) 22:24:27 INFO - PROCESS | 27127 | RSS: Main: 253067264 22:24:27 INFO - PROCESS | 27127 | 22:24:27 INFO - PROCESS | 27127 | __start_tp_report 22:24:27 INFO - PROCESS | 27127 | _x_x_mozilla_page_load 22:24:27 INFO - PROCESS | 27127 | _x_x_mozilla_page_load_details 22:24:27 INFO - PROCESS | 27127 | |i|pagename|runs| 22:24:27 INFO - PROCESS | 27127 | |0;ai-astar;110;113;106;110;112;111;102;111;111;110 22:24:27 INFO - PROCESS | 27127 | |1;audio-beat-detection;158;126;158;167;137;167;158;127;174;126 22:24:27 INFO - PROCESS | 27127 | |2;audio-dft;162;162;162;165;161;161;158;164;163;161 22:24:27 INFO - PROCESS | 27127 | |3;audio-fft;75;74;93;94;73;75;73;113;96;74 22:24:27 INFO - PROCESS | 27127 | |4;audio-oscillator;95;96;139;96;96;96;150;99;97;153 22:24:27 INFO - PROCESS | 27127 | |5;imaging-gaussian-blur;119;116;115;115;115;115;115;115;115;115 22:24:27 INFO - PROCESS | 27127 | |6;imaging-darkroom;145;145;145;146;147;147;145;145;145;146 22:24:27 INFO - PROCESS | 27127 | |7;imaging-desaturate;96;96;97;96;96;96;97;97;96;96 22:24:27 INFO - PROCESS | 27127 | |8;json-parse-financial;57;56;56;56;56;57;57;65;55;54 22:24:27 INFO - PROCESS | 27127 | |9;json-stringify-tinderbox;69;67;67;68;69;68;68;67;67;69 22:24:27 INFO - PROCESS | 27127 | |10;stanford-crypto-aes;81;82;90;81;84;81;84;81;81;82 22:24:27 INFO - PROCESS | 27127 | |11;stanford-crypto-ccm;119;117;121;115;124;122;130;125;115;120 22:24:27 INFO - PROCESS | 27127 | |12;stanford-crypto-pbkdf2;156;140;152;154;152;141;152;149;150;163 22:24:27 INFO - PROCESS | 27127 | |13;stanford-crypto-sha256-iterative;68;70;68;68;70;67;70;71;68;67 22:24:27 INFO - PROCESS | 27127 | __end_tp_report 22:24:27 INFO - PROCESS | 27127 | __start_cc_report 22:24:27 INFO - PROCESS | 27127 | _x_x_mozilla_cycle_collect,975 22:24:27 INFO - PROCESS | 27127 | __end_cc_report 22:24:27 INFO - PROCESS | 27127 | __startTimestamp1454307867712__endTimestamp 22:24:27 INFO - PROCESS | 27127 | 22:24:27 INFO - PROCESS | 27127 | ------- Summary: start ------- 22:24:27 INFO - PROCESS | 27127 | Number of tests: 14 22:24:27 INFO - PROCESS | 27127 | 22:24:27 INFO - PROCESS | 27127 | [#0] ai-astar Cycles:10 Average:109.60 Median:111.00 stddev:3.24 (2.9%) stddev-sans-first:3.43 22:24:27 INFO - PROCESS | 27127 | Values: 110.0 113.0 106.0 110.0 112.0 111.0 102.0 111.0 111.0 110.0 22:24:27 INFO - PROCESS | 27127 | 22:24:27 INFO - PROCESS | 27127 | [#1] audio-beat-detection Cycles:10 Average:149.80 Median:158.00 stddev:18.84 (11.9%) stddev-sans-first:19.75 22:24:27 INFO - PROCESS | 27127 | Values: 158.0 126.0 158.0 167.0 137.0 167.0 158.0 127.0 174.0 126.0 22:24:27 INFO - PROCESS | 27127 | 22:24:27 INFO - PROCESS | 27127 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:1.91 (1.2%) stddev-sans-first:2.03 22:24:27 INFO - PROCESS | 27127 | Values: 162.0 162.0 162.0 165.0 161.0 161.0 158.0 164.0 163.0 161.0 22:24:27 INFO - PROCESS | 27127 | 22:24:27 INFO - PROCESS | 27127 | [#3] audio-fft Cycles:10 Average:84.00 Median:75.00 stddev:14.02 (18.7%) stddev-sans-first:14.49 22:24:27 INFO - PROCESS | 27127 | Values: 75.0 74.0 93.0 94.0 73.0 75.0 73.0 113.0 96.0 74.0 22:24:27 INFO - PROCESS | 27127 | 22:24:27 INFO - PROCESS | 27127 | [#4] audio-oscillator Cycles:10 Average:111.70 Median:96.00 stddev:24.86 (25.9%) stddev-sans-first:25.62 22:24:27 INFO - PROCESS | 27127 | Values: 95.0 96.0 139.0 96.0 96.0 96.0 150.0 99.0 97.0 153.0 22:24:27 INFO - PROCESS | 27127 | 22:24:27 INFO - PROCESS | 27127 | [#5] imaging-gaussian-blur Cycles:10 Average:115.50 Median:115.00 stddev:1.27 (1.1%) stddev-sans-first:0.33 22:24:27 INFO - PROCESS | 27127 | Values: 119.0 116.0 115.0 115.0 115.0 115.0 115.0 115.0 115.0 115.0 22:24:27 INFO - PROCESS | 27127 | 22:24:27 INFO - PROCESS | 27127 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:145.50 stddev:0.84 (0.6%) stddev-sans-first:0.87 22:24:27 INFO - PROCESS | 27127 | Values: 145.0 145.0 145.0 146.0 147.0 147.0 145.0 145.0 145.0 146.0 22:24:27 INFO - PROCESS | 27127 | 22:24:27 INFO - PROCESS | 27127 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 22:24:27 INFO - PROCESS | 27127 | Values: 96.0 96.0 97.0 96.0 96.0 96.0 97.0 97.0 96.0 96.0 22:24:27 INFO - PROCESS | 27127 | 22:24:27 INFO - PROCESS | 27127 | [#8] json-parse-financial Cycles:10 Average:56.90 Median:56.50 stddev:3.00 (5.3%) stddev-sans-first:3.18 22:24:27 INFO - PROCESS | 27127 | Values: 57.0 56.0 56.0 56.0 56.0 57.0 57.0 65.0 55.0 54.0 22:24:27 INFO - PROCESS | 27127 | 22:24:27 INFO - PROCESS | 27127 | [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:68.00 stddev:0.88 (1.3%) stddev-sans-first:0.83 22:24:27 INFO - PROCESS | 27127 | Values: 69.0 67.0 67.0 68.0 69.0 68.0 68.0 67.0 67.0 69.0 22:24:27 INFO - PROCESS | 27127 | 22:24:27 INFO - PROCESS | 27127 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:82.00 stddev:2.83 (3.5%) stddev-sans-first:2.93 22:24:27 INFO - PROCESS | 27127 | Values: 81.0 82.0 90.0 81.0 84.0 81.0 84.0 81.0 81.0 82.0 22:24:27 INFO - PROCESS | 27127 | 22:24:27 INFO - PROCESS | 27127 | [#11] stanford-crypto-ccm Cycles:10 Average:120.80 Median:121.50 stddev:4.71 (3.9%) stddev-sans-first:4.95 22:24:27 INFO - PROCESS | 27127 | Values: 119.0 117.0 121.0 115.0 124.0 122.0 130.0 125.0 115.0 120.0 22:24:27 INFO - PROCESS | 27127 | 22:24:27 INFO - PROCESS | 27127 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.90 Median:152.00 stddev:6.72 (4.4%) stddev-sans-first:6.87 22:24:27 INFO - PROCESS | 27127 | Values: 156.0 140.0 152.0 154.0 152.0 141.0 152.0 149.0 150.0 163.0 22:24:27 INFO - PROCESS | 27127 | 22:24:27 INFO - PROCESS | 27127 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:1.42 (2.1%) stddev-sans-first:1.48 22:24:27 INFO - PROCESS | 27127 | Values: 68.0 70.0 68.0 68.0 70.0 67.0 70.0 71.0 68.0 67.0 22:24:27 INFO - PROCESS | 27127 | -------- Summary: end -------- 22:24:27 INFO - PROCESS | 27127 | 22:24:28 INFO - TEST-INFO | 27127: exit 0 22:24:28 INFO - TEST-OK | kraken | took 59939ms 22:24:28 INFO - SUITE-END | took 1173s 22:24:29 INFO - Completed test suite (00:19:34) 22:24:29 INFO - Working with test: dromaeo_css 22:24:29 INFO - Generating results file: dromaeo_css 22:24:29 INFO - Working with test: kraken 22:24:29 INFO - Generating results file: kraken 22:24:29 INFO - javascript benchmark 22:24:29 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:24:29 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,35]] 22:24:29 INFO - process_Request line: dromaeo_css 6792.33 graph.html#tests=[[72,63,35]] 22:24:29 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:24:29 INFO - process_Request line: kraken 1522.30 graph.html#tests=[[232,63,35]] 22:24:29 INFO - RETURN: dromaeo_css: 6792.33 22:24:29 INFO - RETURN: kraken: 1522.30 22:24:29 INFO - javascript benchmark 22:24:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3066.7086626770456, 3142.9528557071662, 3165.79422337548, 3174.8888788892395, 3207.102011436797, 4991.42598601161, 5065.240213967907, 5176.741162941852, 5188.974055129724, 5232.372115346159, 5062.974685126569, 5067.214581739836, 5097.796088156479, 5101.821436249732, 5129.435762066179, 4535.614472769818, 4634.675572709912, 4636.35091087248, 4643.177882635467, 4782.641301902354, 4799.784009719554, 4822.252550854606, 4850.830220942268, 4872.147374209517, 4878.463369029421, 4606.97696511517, 4657.604103651211, 4699.929501057487, 4756.66703330767, 4812.37439132914, 4711.0342379812055, 4720.150372932871, 4723.976380118112, 4755.310479980418, 4792.137415265286, 4695.037517308978, 4713.245880659112, 4722.409698787652, 4727.338172655831, 4768.141734487791, 4931.087748766489, 5013.724245166514, 5027.723475208899, 5031.823886164003, 5123.487651234884, 5454.699991500466, 5456.427075157131, 5465.398806131322, 5468.070428027245, 5512.614117011811, 5438.211459338413, 5499.450054994469, 5503.6147469677135, 5504.4495550445035, 5516.668999860021, 5087.135187018216, 5158.071547121516, 5164.793408263665, 5266.131088370453, 5287.9735601321745, 5663.1505274208375, 5673.205751194836, 5683.573731970118, 5684.431556844283, 5703.828885133453, 5442.047641662693, 5448.782048718086, 5451.291332126798, 5451.373092094381, 5473.425290344536, 5339.41266460689, 5422.53908417781, 5463.289772329572, 5545.973994810973, 5570.025245582007, 5462.20797984298, 5478.534324582455, 5506.724663766796, 5508.944910550923, 5518.889622207534, 5241.868953276198, 5496.148097044965, 5503.587230957694, 5511.3075973772175, 5514.889702205934, 4284.421603083544, 4297.57024297574, 4318.244307246219, 4370.912581748347, 4379.364992076131, 3809.4857194278416, 3819.6371344722206, 3833.4058220975794, 3853.0, 3853.8843834685003, 5142.665726727751, 5163.586913046947, 5164.0, 5164.535191832753, 5165.811863271469, 5357.678539287655, 5443.020256353815, 5459.918101228484, 5507.146392309119, 5568.387477377485, 5089.109405853961, 5091.694498330112, 5091.9236211456855, 5095.414027386824, 5130.4356520782685, 4591.219492686251, 4669.620611973933, 4673.158831410379, 4675.696079754805, 4690.624750019991, 5704.800331988444, 5729.341125770589, 5753.194552762617, 5778.306603207642, 5801.564882633735, 5516.089845175501, 5516.668999860021, 5518.0, 5518.558515318685, 5521.116621340566, 5600.467955544217, 5686.545076393962, 5751.396103409249, 5754.539636829128, 5761.279840019997, 5403.4326395727885, 5435.157550579508, 5514.80698175562, 5547.722613869371, 5549.084401073777, 5522.30971128609, 5526.668399896019, 5548.500634942875, 5575.553955683455, 5586.636868603528, 5427.701476418835, 5469.808556700496, 5481.972590137183, 5482.753276102505, 5523.25436066142, 5286.259923610621, 5314.840554783363, 5349.358077030781, 5393.730313484231, 5411.594130440311, 5259.868503287448, 5272.209168624737, 5286.550643195372, 5293.523582877559, 5294.179402192666, 5367.329083864517, 5374.193870919394, 5388.488093631099, 5394.865128371822, 5433.347998240237, 5157.7679004444135, 5225.0, 5241.0, 5270.23581580661, 5355.116405793156], "unit": "score", "name": "dojo.html", "value": 5089.972912900919}, {"lowerIsBetter": false, "replicates": [524.4650456534335, 531.5322516185756, 531.5588061908617, 580.9128630705391, 629.8834715577618, 30127.24681882954, 36285.637143628555, 36684.99999999996, 36761.816190919075, 36845.26309473809, 38836.22327553454, 39213.41179882304, 39250.41124383137, 39256.41115383271, 39318.21363572727, 8424.747257582267, 8654.307655387554, 8660.783480413009, 8667.95666021669, 8678.956605216965, 8510.106438823927, 8662.87005694915, 8668.826623467527, 8669.739907802776, 8675.739727808175, 8615.65537378504, 8704.825903481926, 8709.95645021774, 8716.302695784354, 8718.258947989429, 8624.741257762245, 8706.521141337224, 8713.04156542783, 8717.128287171296, 8718.128187181295, 8493.108223636553, 8524.0, 8567.186117318844, 8587.828243435159, 8595.871061934076, 38939.0, 38947.61052389497, 39111.21777564433, 39488.0, 39591.0, 3211.405889910374, 3256.902292931216, 3265.7224135948472, 3829.1384438501113, 4135.255653982282, 29560.70439295601, 30004.649790759468, 30556.54165187524, 30931.536026959613, 30966.53550196749, 3894.883153505399, 3921.745086569364, 3935.3900145477496, 4031.093004074089, 4115.58844115589, 252027.0, 252447.73776131184, 253118.0, 253155.0, 254598.0, 51120.488795111574, 52282.73858630683, 58990.70504647449, 60019.298166674096, 60112.0, 52920.73539632277, 52969.2054619181, 53042.46957530452, 53127.20309195365, 53146.468535314925, 14485.85514144845, 14772.0, 15245.847541524443, 15415.229238538028, 15465.149416782186, 11976.443062401831, 12151.513939442324, 12189.695257618454, 12190.39048047594, 12199.329036903055, 18382.908085459487, 18566.164522596515, 19230.519237018907, 19239.921612541926, 19488.220471181277, 6965.721371145098, 7211.350978411968, 7242.891356629655, 7264.309890560388, 7266.818329541804, 940.8729821474013, 967.1827305926481, 1053.4995876958383, 1064.350746044912, 1069.1446842525947, 28007.0, 28123.859380702965, 28322.291942701184, 28366.71633283682, 28612.427751444855, 1033.612395351743, 1040.0587468341164, 1040.1210976724656, 1046.56567524478, 1052.353067449439, 13002.804957925639, 13637.659058523417, 13668.52160174389, 15051.473198438001, 15247.542573722585, 293334.0, 295638.0, 297526.0, 297731.0, 298911.0, 51750.741246293524, 51920.74039629778, 52072.21891671628, 52123.739381302854, 52153.0, 1194.778965891313, 1264.8166015927638, 1295.0934345957867, 1373.3064802274987, 1389.6595334142999, 25372.701548798537, 25449.236522904343, 26381.736182637927, 28881.277968050967, 29543.409131817672, 43351.78324108359, 43534.78232608816, 43647.78176109099, 43698.56301436945, 43842.780786095864, 280921.0, 290395.0, 291025.0, 348906.0, 355130.0, 27936.161915142577, 28008.43983120367, 28095.578566321932, 28117.43765124727, 28211.294717632223, 42966.0, 44044.77977610091, 44119.33820992624, 45009.0, 45130.77434612806, 36573.0, 36718.44922326221, 37421.81289093537, 37450.250994980495, 38172.0, 37312.493758114884, 37513.81243093767, 38034.429483557215, 38050.61949380582, 38245.80877095597, 35807.82096089503, 36084.27831443304, 36309.27381452409, 36522.26955460929, 36629.26741465209, 32390.514142287415, 33315.500267495525, 33515.497267540515, 33586.664133358354, 33841.0, 25449.363765906, 25476.363090922874, 25541.744582553936, 25564.74435255698, 25793.0], "unit": "score", "name": "ext.html", "value": 18138.778021236623}, {"lowerIsBetter": false, "replicates": [361.6528132992329, 363.4820380957136, 367.06215619093217, 368.81006281764894, 371.747211895911, 13583.932080339584, 13694.959155210187, 16100.35598576057, 16479.176041197938, 17192.570185745364, 15203.467878624251, 15574.053243344582, 16052.518424447257, 16061.277242524086, 16149.515514534552, 5108.923366149511, 5259.474052594729, 5260.184671375943, 5260.815871444481, 5260.947390526103, 3958.6437220650137, 4108.609682080198, 5235.73821308933, 5293.814716484924, 5740.512056475184, 5847.386024467433, 5891.381404952483, 5935.614185077978, 5944.346121926606, 5952.613080149798, 5714.828555143332, 5809.73856176471, 5813.47678708914, 5813.82558523245, 5831.03787874998, 5016.3980322361185, 5032.47159048302, 5069.340985671839, 5161.8193363232485, 5171.120909445403, 19705.31031413908, 19820.30628927995, 19853.50366240841, 20158.79841201584, 20385.08267127983, 2282.8173746100274, 2329.6738456616085, 2388.868612226327, 2417.2443414507475, 2794.9441011179865, 9117.726468205965, 12990.0, 12991.155574887602, 13013.804792928113, 13368.264745438997, 1763.0920076160787, 1843.935462258828, 1844.7786265648074, 1861.7486639303656, 1931.7392152059433, 56484.71757641186, 58805.0, 60682.0, 60782.696086519725, 61348.705590608675, 10121.797564048678, 10223.079922806983, 10250.436226007641, 10251.794964100676, 10299.742506437398, 12624.873751262554, 13658.453661853613, 13675.974301927396, 13700.3834827433, 13729.28383952006, 7212.954121652331, 7416.214387694687, 7680.34717049046, 7730.690772369155, 7751.496152750054, 7445.292697193758, 7469.551826890295, 7474.0, 7516.173220945691, 7531.133919599207, 4480.193565158303, 4494.662900282492, 4503.3245013247615, 4526.298423744325, 4548.840790572314, 1694.4238958754083, 1770.7166853303668, 1791.1313013188594, 1820.8270214329618, 1850.3246315094893, 901.2609660078673, 911.2300106410073, 927.2859897878595, 965.7537327981461, 1002.0981116994762, 15332.156731379659, 15598.376064957274, 15834.920825395799, 15986.520404387888, 16933.83066169347, 875.7591662292921, 898.2275243290765, 962.2398305338844, 967.8257913575624, 1014.3102690170607, 8719.476831390137, 9184.403013804082, 9217.216536594464, 9803.264755143251, 9832.115109640166, 349910.0, 524159.0, 525713.0, 559730.0, 572137.2786272167, 61840.0, 62017.0, 63074.68462657657, 64004.35995639984, 75844.24155758483, 1153.700037990112, 1175.1304035014027, 1180.9822852657217, 1192.5170306026073, 1193.9880601193877, 11274.943625281821, 14221.360038798071, 14789.0, 14869.182194978946, 15350.385984560493, 31489.527657084705, 32629.510557341186, 33014.50478242876, 34175.0, 34539.4819077709, 37325.253494929406, 42770.14459710726, 45346.31980520361, 48932.266016009075, 49406.25890611572, 7380.261973802577, 7396.740132447631, 7427.554346739213, 7829.256220659028, 8002.599870006593, 9543.761405964906, 11754.177207595387, 11974.880251197377, 12033.097517686034, 12081.939590301992, 9878.555465004236, 9937.701868943943, 10183.592656293666, 10351.585936562453, 10465.47672616351, 9964.202863771026, 10162.23783216247, 10292.433916134685, 10349.9482502587, 10496.405818486259, 10179.592816287266, 10410.0, 10449.164066874784, 10489.29603102374, 10562.31344962575, 7625.961870190614, 7773.650185741768, 7786.61066946639, 7836.138024817379, 7877.8818317724135, 8866.866996995179, 10574.8413773795, 10620.20348473883, 10682.89317106819, 10872.782544348911], "unit": "score", "name": "jquery.html", "value": 8325.906127884109}, {"lowerIsBetter": false, "replicates": [1300.1224173682774, 1457.1912588513374, 1468.8237411510618, 1625.3092435714825, 1777.4312220089575, 6866.725330986761, 7464.813379665511, 7619.352355049814, 7657.081150261976, 7667.769966901002, 7539.0, 7730.072391313036, 7742.961285193566, 7750.457467977244, 7751.534907905516, 1973.733545971297, 2026.625074361248, 2216.5345277491747, 2232.073689418889, 2244.124791331382, 2276.157821606008, 2281.7376001759844, 2284.851484653492, 2287.8970446329954, 2292.484191057007, 2192.1888901106613, 2265.694131292271, 2272.6022945984387, 2275.6358982562792, 2275.681404603357, 2209.834262430316, 2240.0591751464344, 2241.5628952354214, 2296.632538793785, 2298.344971683079, 2235.653473711577, 2253.7182852143483, 2264.2867496738477, 2268.0700912625907, 2275.249167774647, 7770.49491783038, 7806.609669516558, 7809.0, 7841.568713720743, 7848.489848159851, 4550.340200670884, 4591.816327346902, 4639.0, 4640.09518143962, 4644.256918892961, 3030.1515575638855, 3083.1521331633758, 3116.532520121977, 3134.576832127679, 3182.809031458097, 923.0446487885074, 939.0843927171022, 942.180303136269, 964.6189755046787, 1014.1987829614669, 10147.137493313077, 10308.484575771181, 10333.276670633059, 10344.32761870476, 10357.63748268807, 3941.8620348287673, 4046.9392959105635, 4124.896877578085, 4128.649064829523, 4141.047559061432, 8563.743087707378, 8733.297007083685, 8756.080611535697, 8763.123687631314, 8770.956145219234, 4738.976305118521, 4745.454272758608, 4763.76181190939, 4765.571098601074, 4768.189407800683, 4368.803403846835, 4405.052913623522, 4410.691251612357, 4412.161689279027, 4417.160739459492, 3190.090824115116, 3214.083986064007, 3291.3581851539197, 3355.9496607550905, 3468.3063387322636, 974.571188676994, 1011.2920955331298, 1015.6140666546665, 1016.5577973581516, 1018.5721996761378, 1253.2417887178308, 1269.650846017334, 1286.948522059126, 1312.3831799054428, 1322.702391961801, 7049.647517624201, 7049.8237544060785, 7308.926910730931, 7485.513441626277, 7488.700451981968, 1093.8632670916136, 1100.6422912553453, 1113.1095123900848, 1122.9775404491863, 1128.7234627516148, 5742.368339482737, 5807.709614519257, 5808.128780682931, 5815.069588865761, 5816.88366232673, 9095.954520227357, 9152.725418237464, 9338.299627527962, 9371.859422108673, 9470.621175152917, 9494.810103798023, 9518.381305215138, 9616.567254473426, 9628.229741620653, 9633.951830240943, 7050.400715939202, 7123.643817809088, 7267.745628902963, 7277.563346199351, 7280.817979550554, 7017.614031228331, 7032.578045317093, 7036.718531258693, 7038.225795162631, 7041.929580704127, 7932.0, 8188.0, 8268.462549934235, 8379.832403351777, 8407.53758543286, 8370.869932559026, 8439.535825529654, 8556.058833528183, 8559.0, 8570.657173712982, 6726.6636668167375, 6940.0, 6955.061066755923, 6980.267071957372, 6988.685509151998, 6606.735730570916, 6731.461483081243, 7164.677589508589, 7450.180480147071, 7461.888071678821, 6574.940341277853, 6809.965950170217, 6934.133233345832, 6968.581885086911, 7123.430125590044, 6817.147856517935, 6846.315368463114, 6925.826854328682, 6952.339527744856, 7076.964615176891, 6461.06314584392, 6509.576877502947, 6510.772122975863, 6512.3162067982175, 6515.218173819172, 6012.188354572077, 6051.33435322123, 6084.756609735561, 6138.846528836815, 6154.907676384947, 6163.84590385244, 6185.134081228722, 6194.969025154845, 6200.193974783249, 6238.500919926486], "unit": "score", "name": "mootools.html", "value": 4401.276875345467}, {"lowerIsBetter": false, "replicates": [343.56710544713656, 349.90902365384994, 350.1543771791124, 357.47451246667424, 362.3097998313214, 5643.125315576092, 5755.050416681248, 5761.510271626907, 5766.538676905848, 5845.912311315328, 5619.7471113799875, 5738.368779434259, 5739.167820666001, 5762.683052432115, 5782.855428614287, 4554.908901821962, 4561.133384656921, 4565.949831538748, 4569.565891240343, 4573.885652858672, 4287.378330142127, 4411.911761764763, 4436.334549817537, 4534.206513860077, 4559.544045595447, 4483.282674772037, 4485.775711214426, 4496.4829044659955, 4497.123061003105, 4500.932486012713, 4465.955340446602, 4486.663500237479, 4500.369948207221, 4508.5266047064915, 4540.72755634663, 4020.597940205956, 4028.6777057835598, 4036.7577945323374, 4037.0916543777416, 4042.0299128209017, 5373.892522149574, 5508.944910550883, 5537.141743029837, 5554.166874968787, 5562.054450743383, 5172.327597412313, 5174.534291913746, 5177.430482646906, 5178.0, 5179.352580927384, 5879.206307148523, 6217.533684973645, 6224.159738435299, 6228.003519436868, 6231.6572588507615, 4241.278982572939, 4286.57134286572, 4389.429374181368, 4390.495093064306, 4390.582894625006, 6410.647414392207, 6448.322926092739, 6476.093346931433, 6477.417032467053, 6499.447546958514, 4482.350059241392, 4483.641308695296, 4484.080763443486, 4484.9103017940115, 4493.820247190141, 4456.108778244364, 4493.955060449419, 4543.182227199136, 4547.431571053618, 4550.0217453247715, 5174.197999310113, 5195.792168313225, 5196.870078247998, 5197.66215196011, 5211.348581427322, 6213.0, 6213.906791398133, 6217.813465596039, 6220.875582488325, 6225.221847269091, 1578.6369135098992, 1602.2149146917927, 1608.9115098669452, 1610.4604957339188, 1611.1460925709393, 1069.2141276162015, 1082.1126676125502, 1090.3076546393097, 1091.8198497247865, 1099.587654629514, 5869.765209391577, 5871.9706401468575, 5874.030784920526, 5884.411558844167, 5907.084401917709, 6384.553081284265, 6385.96807015962, 6387.105805187278, 6401.263854656681, 6403.903941440882, 5929.229200204032, 5959.702014899238, 5960.344362120163, 5979.431953964367, 5980.760769569256, 3332.683395077464, 3396.881109161217, 3429.605595356566, 3444.6727560881677, 3446.551948246712, 6634.601923884582, 6647.202335719745, 6700.329967003261, 6760.425363844129, 6765.391114799691, 6602.900956485657, 6627.668616569249, 6643.036759669821, 6643.50173736962, 6651.301613330531, 6587.73649054042, 6692.263850976388, 6696.665166741644, 6704.9607310866895, 6722.327767223239, 6164.921138800782, 6325.399087086719, 6422.678866056772, 6438.356164383524, 6438.742450301936, 6231.9688401557705, 6360.459360954371, 6374.1394911688185, 6381.3937675920715, 6395.648239346694, 6672.633005184762, 6698.363655452724, 6700.631465269262, 6709.832254193684, 6715.764948226789, 4530.728156310632, 4575.885602859955, 4618.491965883817, 4620.330052142488, 4628.930566041579, 6350.587211831216, 6352.174217351715, 6353.364663533795, 6354.618722876642, 6356.459700925288, 6187.628742275478, 6188.938110618837, 6193.566450348432, 6193.721282542207, 6201.472874805511, 6053.213082299273, 6178.764247150498, 6190.102435146969, 6194.473469755121, 6194.969025154845, 6070.18052562916, 6075.756969721162, 6076.270847498328, 6084.087386892002, 6086.147939288415, 6177.227846519185, 6210.503159747119, 6210.968945155245, 6221.502279817694, 6222.253329600477, 5955.344912059583, 6069.180660610761, 6075.149479073022, 6080.300765412034, 6080.604760690541], "unit": "score", "name": "prototype.html", "value": 4709.827236916209}, {"lowerIsBetter": false, "replicates": [685.4208194076004, 794.6636887550602, 817.0971076959959, 818.529345626265, 822.0135836995606, 13927.930360348197, 14032.64918377041, 14061.859381406182, 14068.085574437668, 14147.929260353696, 12924.676883077927, 14153.22157281349, 14519.564413067625, 14571.708565828703, 14582.375172468952, 662.092932682226, 676.7665155521362, 792.5878543157554, 804.8752443371287, 808.1231863428187, 784.1022029775903, 785.458033956571, 791.6674996501455, 792.0, 796.7052190689453, 845.4293351987415, 846.7459762071354, 847.4364547575885, 847.4406891451644, 847.5677404523676, 680.7889554238202, 698.5564166754123, 825.3232349473434, 844.0883845446903, 844.6832437835811, 619.5136817598209, 620.1658768955747, 620.7020630097534, 622.1072760588524, 622.5704264057786, 13250.86749132506, 13279.402426890812, 13341.86658133416, 13364.264965426897, 13396.732065358736, 12289.56986505477, 12358.196717213352, 12442.751144977141, 12492.500299987989, 12765.489380424771, 10605.363678179334, 10622.840657390145, 10747.516361763739, 11597.4201289936, 11750.294982301004, 4358.150160718661, 4394.8901277468, 4509.977450112761, 4530.1392735380505, 4548.5906268436, 45676.0, 46164.53835461636, 46566.53433465656, 46653.0, 46703.29945050827, 9761.73745770222, 10130.290879638354, 10139.239557033105, 10190.337628054152, 10391.584336626602, 18062.63874722498, 18119.547011324557, 18120.365787197385, 18350.082495875155, 18404.907975460304, 7375.373093287023, 7615.581143037186, 7665.540067595962, 7839.0, 7853.646585903648, 4286.37847512109, 4319.697621166488, 4322.740635561876, 4373.1472362888935, 4491.191585514639, 3197.7441804655573, 3210.470272405027, 3219.4848824188016, 3240.1089700332595, 3245.8052516849066, 587.224863180606, 606.5875204860737, 618.4959258204549, 656.9080328753978, 679.6092246958019, 645.3514218210762, 662.5730414974764, 669.5112567825514, 682.8634273145292, 690.1580072311772, 7759.469441404148, 8161.79595510117, 8301.584920753938, 8406.747797566082, 8436.704715334934, 571.4428432278495, 593.8283558005049, 636.8789929913302, 641.4611726150056, 658.6542065415599, 3770.1140232045445, 3810.237952409529, 3860.401637746154, 3966.8413263469715, 3977.801109944491, 50175.0, 50813.74593127011, 51000.74499627478, 51243.7437812816, 51474.74262628663, 43571.56428435739, 43865.78067109644, 44546.77726611346, 47212.7639361801, 47869.28196077062, 40248.396274055915, 40886.1822763549, 43369.0, 43380.78309608432, 43879.0, 7669.769906902802, 7741.806454838674, 7827.608619568885, 7835.647395867314, 7878.448508604342, 32474.35051299008, 32488.51267230946, 32977.67022329746, 33174.0, 33338.166545836546, 39218.80390598029, 41359.37960930649, 42173.0, 42926.78536607297, 42934.141317172856, 10573.2598718089, 10663.680089597325, 10734.087602553558, 10793.352398856094, 10916.727081823017, 11160.33038017689, 11409.087273018305, 11413.771724565297, 11434.48544815502, 11916.285022898654, 9460.95269523648, 9843.85234221473, 10241.487925603838, 10258.743531411774, 10417.84373234387, 10161.695149145242, 10846.620368287073, 10881.748598911227, 11189.21675482741, 11279.887201127884, 9887.901120988698, 9944.204463643036, 10121.765223137105, 10196.286259961731, 10247.7438064049, 8719.91280087191, 8974.461532308082, 9046.638134474548, 9238.491882946502, 9293.535323233946, 8075.555844428378, 8498.447600905922, 8663.176998185163, 9027.187553120251, 9141.542922853963], "unit": "score", "name": "yui.html", "value": 6162.201998874281}], "name": "dromaeo_css", "value": 6792.332828581881}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 113.0, 106.0, 110.0, 112.0, 111.0, 102.0, 111.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 109.6}, {"lowerIsBetter": true, "replicates": [158.0, 126.0, 158.0, 167.0, 137.0, 167.0, 158.0, 127.0, 174.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 149.8}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 162.0, 165.0, 161.0, 161.0, 158.0, 164.0, 163.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.9}, {"lowerIsBetter": true, "replicates": [75.0, 74.0, 93.0, 94.0, 73.0, 75.0, 73.0, 113.0, 96.0, 74.0], "unit": "score", "name": "audio-fft", "value": 84.0}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 139.0, 96.0, 96.0, 96.0, 150.0, 99.0, 97.0, 153.0], "unit": "score", "name": "audio-oscillator", "value": 111.7}, {"lowerIsBetter": true, "replicates": [119.0, 116.0, 115.0, 115.0, 115.0, 115.0, 115.0, 115.0, 115.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.5}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 146.0, 147.0, 147.0, 145.0, 145.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 97.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 56.0, 56.0, 56.0, 57.0, 57.0, 65.0, 55.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.9}, {"lowerIsBetter": true, "replicates": [69.0, 67.0, 67.0, 68.0, 69.0, 68.0, 68.0, 67.0, 67.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.9}, {"lowerIsBetter": true, "replicates": [81.0, 82.0, 90.0, 81.0, 84.0, 81.0, 84.0, 81.0, 81.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.7}, {"lowerIsBetter": true, "replicates": [119.0, 117.0, 121.0, 115.0, 124.0, 122.0, 130.0, 125.0, 115.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.8}, {"lowerIsBetter": true, "replicates": [156.0, 140.0, 152.0, 154.0, 152.0, 141.0, 152.0, 149.0, 150.0, 163.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.9}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 68.0, 68.0, 70.0, 67.0, 70.0, 71.0, 68.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.7}], "name": "kraken", "value": 1522.3000000000002}]} 22:24:29 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,35]]", "result": "1522.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,35]]", "result": "6792.33"}}} 22:24:29 INFO - Return code: 0 22:24:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 22:24:29 INFO - # TBPL SUCCESS # 22:24:29 INFO - Running post-action listener: _resource_record_post_action 22:24:29 INFO - Running post-run listener: _resource_record_post_run 22:24:30 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 16384; Write bytes: 546852864; Read time: 116; Write time: 859480 22:24:30 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 0; Write bytes: 238661632; Read time: 0; Write time: 528068 22:24:30 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 16384; Write bytes: 296652800; Read time: 116; Write time: 327140 22:24:30 INFO - Running post-run listener: _upload_blobber_files 22:24:30 INFO - Blob upload gear active. 22:24:30 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 22:24: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:24: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', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 22:24: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 Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 22:24:31 INFO - (blobuploader) - INFO - Open directory for files ... 22:24:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:24:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:24:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:24:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:24:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:24:31 INFO - (blobuploader) - INFO - Done attempting. 22:24:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 22:24:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:24:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:24:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:24:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:24:32 INFO - (blobuploader) - INFO - Done attempting. 22:24:32 INFO - (blobuploader) - INFO - Iteration through files over. 22:24:32 INFO - Return code: 0 22:24:32 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 22:24:32 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 22:24:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/223abdb80e4f3d6d05f4867da77547b10ac0032fd3185661e771dcfbfded44d0dc0bc83d6b2ada21efd32e785dc8abcdaa8f85f0b729f07a007ce04d6c43aff4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dd5ace2f6ff72ff634d17237ef2cebabce1f3c57da66e89c5ddb0c4b2ceebf8895a8148eefba7ec623b70b4f9c734a7c2ef8fb5b04becbfadf00835655b48f04"} 22:24:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 22:24:32 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 22:24:32 INFO - Contents: 22:24:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/223abdb80e4f3d6d05f4867da77547b10ac0032fd3185661e771dcfbfded44d0dc0bc83d6b2ada21efd32e785dc8abcdaa8f85f0b729f07a007ce04d6c43aff4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dd5ace2f6ff72ff634d17237ef2cebabce1f3c57da66e89c5ddb0c4b2ceebf8895a8148eefba7ec623b70b4f9c734a7c2ef8fb5b04becbfadf00835655b48f04"} 22:24:32 INFO - Running post-run listener: copy_logs_to_upload_dir 22:24:32 INFO - Copying logs to upload dir... 22:24:32 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 22:24:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.669515 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-01-31 22:24:32.200992) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-31 22:24:32.204849) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1454302271.423393-2069714738 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/223abdb80e4f3d6d05f4867da77547b10ac0032fd3185661e771dcfbfded44d0dc0bc83d6b2ada21efd32e785dc8abcdaa8f85f0b729f07a007ce04d6c43aff4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dd5ace2f6ff72ff634d17237ef2cebabce1f3c57da66e89c5ddb0c4b2ceebf8895a8148eefba7ec623b70b4f9c734a7c2ef8fb5b04becbfadf00835655b48f04"} build_url:https://queue.taskcluster.net/v1/task/SaYEH2gJQZWugE5-HzWKXA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011221 build_url: 'https://queue.taskcluster.net/v1/task/SaYEH2gJQZWugE5-HzWKXA/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/Mozilla-Inbound/sha512/223abdb80e4f3d6d05f4867da77547b10ac0032fd3185661e771dcfbfded44d0dc0bc83d6b2ada21efd32e785dc8abcdaa8f85f0b729f07a007ce04d6c43aff4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dd5ace2f6ff72ff634d17237ef2cebabce1f3c57da66e89c5ddb0c4b2ceebf8895a8148eefba7ec623b70b4f9c734a7c2ef8fb5b04becbfadf00835655b48f04"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-31 22:24:32.229619) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-31 22:24:32.229946) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1454302271.423393-2069714738 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004447 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-31 22:24:32.313128) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-31 22:24:32.313451) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-31 22:24:32.313749) ========= ========= Total master_lag: 0.23 =========