builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-003 starttime: 1457712523.36 results: success (0) buildid: 20160311053012 builduid: 23d499fe49b6458cb66a364725fac8a4 revision: 7feee955891b1a600f78541e69e0e6a72b32cfc4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-11 08:08:43.365327) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-11 08:08:43.365844) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-11 08:08:43.366179) ========= 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=7de08804244eb36560b44971000001c3-1457712522.837059-206446385 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006115 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-11 08:08:43.387323) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-11 08:08:43.387679) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-11 08:08:43.401533) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 08:08:43.401897) ========= 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=7de08804244eb36560b44971000001c3-1457712522.837059-206446385 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004510 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 08:08:43.454389) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-11 08:08:43.455026) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-11 08:08:43.455875) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 08:08:43.456574) ========= 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=7de08804244eb36560b44971000001c3-1457712522.837059-206446385 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-11 08:08:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.2M=0s 2016-03-11 08:08:43 (40.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.108123 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 08:08:43.579260) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 08:08:43.579616) ========= 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=7de08804244eb36560b44971000001c3-1457712522.837059-206446385 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021250 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 08:08:43.629508) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 08:08:43.629896) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7feee955891b1a600f78541e69e0e6a72b32cfc4 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 7feee955891b1a600f78541e69e0e6a72b32cfc4 --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=7de08804244eb36560b44971000001c3-1457712522.837059-206446385 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-11 08:08:43,876 truncating revision to first 12 chars 2016-03-11 08:08:43,876 Setting DEBUG logging. 2016-03-11 08:08:43,877 attempt 1/10 2016-03-11 08:08:43,877 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7feee955891b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-11 08:08:44,138 unpacking tar archive at: fx-team-7feee955891b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.547381 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 08:08:44.191333) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-11 08:08:44.191761) ========= echo 7feee955891b1a600f78541e69e0e6a72b32cfc4 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'7feee955891b1a600f78541e69e0e6a72b32cfc4'] 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=7de08804244eb36560b44971000001c3-1457712522.837059-206446385 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 7feee955891b1a600f78541e69e0e6a72b32cfc4 program finished with exit code 0 elapsedTime=0.004646 script_repo_revision: '7feee955891b1a600f78541e69e0e6a72b32cfc4' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-11 08:08:44.246435) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-11 08:08:44.247066) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-11 08:08:44.258655) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-03-11 08:08:44.259209) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7de08804244eb36560b44971000001c3-1457712522.837059-206446385 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:08:44 INFO - MultiFileLogger online at 20160311 08:08:44 in /builds/slave/test-pgo 08:08:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:08:44 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 08:08:44 INFO - {'append_to_log': False, 08:08:44 INFO - 'base_work_dir': '/builds/slave/test-pgo', 08:08:44 INFO - 'blob_upload_branch': 'Fx-Team', 08:08:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 08:08:44 INFO - 'branch': 'Fx-Team', 08:08:44 INFO - 'buildbot_json_path': 'buildprops.json', 08:08:44 INFO - 'config_files': ('talos/linux_config.py',), 08:08:44 INFO - 'default_actions': ('clobber', 08:08:44 INFO - 'read-buildbot-config', 08:08:44 INFO - 'download-and-extract', 08:08:44 INFO - 'populate-webroot', 08:08:44 INFO - 'create-virtualenv', 08:08:44 INFO - 'install', 08:08:44 INFO - 'run-tests'), 08:08:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:08:44 INFO - 'download_minidump_stackwalk': True, 08:08:44 INFO - 'download_symbols': 'ondemand', 08:08:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:08:44 INFO - 'tooltool.py': '/tools/tooltool.py', 08:08:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:08:44 INFO - '/tools/misc-python/virtualenv.py')}, 08:08:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:08:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:08:44 INFO - 'installer_path': 'installer.exe', 08:08:44 INFO - 'log_level': 'info', 08:08:44 INFO - 'log_name': 'talos', 08:08:44 INFO - 'log_to_console': True, 08:08:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:08:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:08:44 INFO - 'opt_config_files': (), 08:08:44 INFO - 'pip_index': False, 08:08:44 INFO - 'sps_profile': False, 08:08:44 INFO - 'sps_profile_interval': 0, 08:08:44 INFO - 'suite': 'dromaeojs', 08:08:44 INFO - 'system_bits': '32', 08:08:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:08:44 INFO - 'title': 'talos-linux64-ix-003', 08:08:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:08:44 INFO - 'use_talos_json': True, 08:08:44 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 08:08:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:08:44 INFO - 'work_dir': 'build'} 08:08:44 INFO - ##### 08:08:44 INFO - ##### Running clobber step. 08:08:44 INFO - ##### 08:08:44 INFO - Running pre-action listener: _resource_record_pre_action 08:08:44 INFO - Running main action method: clobber 08:08:44 INFO - rmtree: /builds/slave/test-pgo/build 08:08:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 08:08:45 INFO - Running post-action listener: _resource_record_post_action 08:08:45 INFO - ##### 08:08:45 INFO - ##### Running read-buildbot-config step. 08:08:45 INFO - ##### 08:08:45 INFO - Running pre-action listener: _resource_record_pre_action 08:08:45 INFO - Running main action method: read_buildbot_config 08:08:45 INFO - Using buildbot properties: 08:08:45 INFO - { 08:08:45 INFO - "project": "", 08:08:45 INFO - "product": "firefox", 08:08:45 INFO - "script_repo_revision": "production", 08:08:45 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:08:45 INFO - "repository": "", 08:08:45 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:08:45 INFO - "buildid": "20160311053012", 08:08:45 INFO - "pgo_build": "True", 08:08:45 INFO - "basedir": "/builds/slave/test-pgo", 08:08:45 INFO - "buildnumber": 997, 08:08:45 INFO - "slavename": "talos-linux64-ix-003", 08:08:45 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:08:45 INFO - "platform": "ubuntu64_hw", 08:08:45 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:08:45 INFO - "branch": "fx-team", 08:08:45 INFO - "repo_path": "integration/fx-team", 08:08:45 INFO - "revision": "7feee955891b1a600f78541e69e0e6a72b32cfc4", 08:08:45 INFO - "stage_platform": "linux64-pgo", 08:08:45 INFO - "builduid": "23d499fe49b6458cb66a364725fac8a4", 08:08:45 INFO - "slavebuilddir": "test" 08:08:45 INFO - } 08:08:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/EymNfJgBS76aErO5LXsoig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 08:08:45 INFO - Running post-action listener: _resource_record_post_action 08:08:45 INFO - ##### 08:08:45 INFO - ##### Running download-and-extract step. 08:08:45 INFO - ##### 08:08:45 INFO - Running pre-action listener: _resource_record_pre_action 08:08:45 INFO - Running main action method: download_and_extract 08:08:45 INFO - mkdir: /builds/slave/test-pgo/build/tests 08:08:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:45 INFO - https://queue.taskcluster.net/v1/task/EymNfJgBS76aErO5LXsoig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:08:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EymNfJgBS76aErO5LXsoig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:08:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EymNfJgBS76aErO5LXsoig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:08:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EymNfJgBS76aErO5LXsoig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:08:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EymNfJgBS76aErO5LXsoig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:08:45 INFO - Downloaded 1361 bytes. 08:08:45 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:08:45 INFO - Using the following test package requirements: 08:08:45 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:08:45 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:45 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:08:45 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:45 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:08:45 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:45 INFO - u'jsshell-linux-x86_64.zip'], 08:08:45 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:45 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:08:45 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:08:45 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:45 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:08:45 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:45 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:08:45 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:45 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:08:45 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:45 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:08:45 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:08:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:45 INFO - https://queue.taskcluster.net/v1/task/EymNfJgBS76aErO5LXsoig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:08:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EymNfJgBS76aErO5LXsoig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:08:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EymNfJgBS76aErO5LXsoig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:08:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EymNfJgBS76aErO5LXsoig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:08:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EymNfJgBS76aErO5LXsoig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:08:47 INFO - Downloaded 23410610 bytes. 08:08:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 08:08:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 08:08:48 INFO - Return code: 0 08:08:48 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:08:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:48 INFO - https://queue.taskcluster.net/v1/task/EymNfJgBS76aErO5LXsoig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:08:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EymNfJgBS76aErO5LXsoig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:08:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EymNfJgBS76aErO5LXsoig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:08:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EymNfJgBS76aErO5LXsoig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:08:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EymNfJgBS76aErO5LXsoig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:08:50 INFO - Downloaded 23410610 bytes. 08:08:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 08:08:50 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 08:08:52 INFO - Return code: 0 08:08:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:52 INFO - https://queue.taskcluster.net/v1/task/EymNfJgBS76aErO5LXsoig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:08:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EymNfJgBS76aErO5LXsoig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:08:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EymNfJgBS76aErO5LXsoig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:08:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EymNfJgBS76aErO5LXsoig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:08:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EymNfJgBS76aErO5LXsoig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:08:54 INFO - Downloaded 10845161 bytes. 08:08:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 08:08:54 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 08:08:54 INFO - Return code: 0 08:08:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:54 INFO - https://queue.taskcluster.net/v1/task/EymNfJgBS76aErO5LXsoig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:08:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EymNfJgBS76aErO5LXsoig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:08:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EymNfJgBS76aErO5LXsoig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:08:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EymNfJgBS76aErO5LXsoig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:08:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EymNfJgBS76aErO5LXsoig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:09:03 INFO - Downloaded 56229352 bytes. 08:09:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EymNfJgBS76aErO5LXsoig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:09:03 INFO - mkdir: /builds/slave/test-pgo/properties 08:09:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 08:09:03 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 08:09:03 INFO - Contents: 08:09:03 INFO - build_url:https://queue.taskcluster.net/v1/task/EymNfJgBS76aErO5LXsoig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:09:04 INFO - Running post-action listener: _resource_record_post_action 08:09:04 INFO - Running post-action listener: set_extra_try_arguments 08:09:04 INFO - ##### 08:09:04 INFO - ##### Running populate-webroot step. 08:09:04 INFO - ##### 08:09:04 INFO - Running pre-action listener: _resource_record_pre_action 08:09:04 INFO - Running main action method: populate_webroot 08:09:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:09:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:09:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:09:04 INFO - '--tppagecycles', 08:09:04 INFO - '7'], 08:09:04 INFO - 'tests': ['tsvgm']}}, 08:09:04 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:09:04 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:09:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:09:04 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 08:09:04 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:09:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:09:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:09:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:04 INFO - 'talos_options': ['--e10s'], 08:09:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:09:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:04 INFO - 'tests': ['damp', 'tps']}, 08:09:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:04 INFO - 'talos_options': ['--e10s'], 08:09:04 INFO - 'tests': ['damp', 'tps']}, 08:09:04 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:09:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:09:04 INFO - 'other': {'tests': ['a11yr', 08:09:04 INFO - 'ts_paint', 08:09:04 INFO - 'tpaint', 08:09:04 INFO - 'sessionrestore', 08:09:04 INFO - 'sessionrestore_no_auto_restore', 08:09:04 INFO - 'tabpaint']}, 08:09:04 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:09:04 INFO - 'tests': ['a11yr', 08:09:04 INFO - 'ts_paint', 08:09:04 INFO - 'tpaint', 08:09:04 INFO - 'sessionrestore', 08:09:04 INFO - 'sessionrestore_no_auto_restore', 08:09:04 INFO - 'tabpaint']}, 08:09:04 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:09:04 INFO - 'tests': ['a11yr', 08:09:04 INFO - 'ts_paint', 08:09:04 INFO - 'tpaint', 08:09:04 INFO - 'sessionrestore', 08:09:04 INFO - 'sessionrestore_no_auto_restore', 08:09:04 INFO - 'tabpaint']}, 08:09:04 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:09:04 INFO - 'tests': ['a11yr', 08:09:04 INFO - 'ts_paint', 08:09:04 INFO - 'tpaint', 08:09:04 INFO - 'sessionrestore', 08:09:04 INFO - 'sessionrestore_no_auto_restore', 08:09:04 INFO - 'tabpaint']}, 08:09:04 INFO - 'other_l64': {'tests': ['a11yr', 08:09:04 INFO - 'ts_paint', 08:09:04 INFO - 'tpaint', 08:09:04 INFO - 'sessionrestore', 08:09:04 INFO - 'sessionrestore_no_auto_restore', 08:09:04 INFO - 'tabpaint']}, 08:09:04 INFO - 'other_nol64': {'tests': ['a11yr', 08:09:04 INFO - 'ts_paint', 08:09:04 INFO - 'tpaint', 08:09:04 INFO - 'sessionrestore', 08:09:04 INFO - 'sessionrestore_no_auto_restore', 08:09:04 INFO - 'tabpaint']}, 08:09:04 INFO - 'svgr': {'tests': ['tsvgx', 08:09:04 INFO - 'tsvgr_opacity', 08:09:04 INFO - 'tart', 08:09:04 INFO - 'tscrollx', 08:09:04 INFO - 'cart']}, 08:09:04 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:09:04 INFO - 'tests': ['tsvgx', 08:09:04 INFO - 'tsvgr_opacity', 08:09:04 INFO - 'tart', 08:09:04 INFO - 'tscrollx', 08:09:04 INFO - 'cart']}, 08:09:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:04 INFO - 'tests': ['tp5o']}, 08:09:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:04 INFO - 'talos_options': ['--e10s'], 08:09:04 INFO - 'tests': ['tp5o']}, 08:09:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:04 INFO - 'talos_options': ['--xperf_path', 08:09:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:09:04 INFO - 'tests': ['tp5n']}, 08:09:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:04 INFO - 'talos_options': ['--e10s', 08:09:04 INFO - '--xperf_path', 08:09:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:09:04 INFO - 'tests': ['tp5n']}}, 08:09:04 INFO - 'talos.zip': {'path': '', 08:09:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:09:04 INFO - Running post-action listener: _resource_record_post_action 08:09:04 INFO - ##### 08:09:04 INFO - ##### Running create-virtualenv step. 08:09:04 INFO - ##### 08:09:04 INFO - Running pre-action listener: _resource_record_pre_action 08:09:04 INFO - Running main action method: create_virtualenv 08:09:04 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 08:09:04 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 08:09:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 08:09:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:09:04 INFO - Using real prefix '/usr' 08:09:04 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 08:09:04 INFO - Installing distribute.............................................................................................................................................................................................done. 08:09:06 INFO - Installing pip.................done. 08:09:06 INFO - Return code: 0 08:09:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 08:09:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:06 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 0x7f862e2b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17356d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c4920>, '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 0x17c5820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c5cb0>, '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': '7de08804244eb36560b44971000001c3-1457712522.837059-206446385', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:09:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 08:09:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:09:06 INFO - Using env: {'DISPLAY': ':0', 08:09:06 INFO - 'HOME': '/home/cltbld', 08:09:06 INFO - 'LANG': 'en_US.UTF-8', 08:09:06 INFO - 'LANGUAGE': 'en_US:en', 08:09:06 INFO - 'LOGNAME': 'cltbld', 08:09:06 INFO - 'MAIL': '/var/mail/cltbld', 08:09:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:06 INFO - 'MOZ_NO_REMOTE': '1', 08:09:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:06 INFO - 'NO_EM_RESTART': '1', 08:09:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:09:06 INFO - 'PWD': '/builds/slave/test-pgo', 08:09:06 INFO - 'SHELL': '/bin/bash', 08:09:06 INFO - 'SHLVL': '1', 08:09:06 INFO - 'TERM': 'linux', 08:09:06 INFO - 'TMOUT': '86400', 08:09:06 INFO - 'USER': 'cltbld', 08:09:06 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1457712522.837059-206446385', 08:09:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:06 INFO - '_': '/tools/buildbot/bin/python'} 08:09:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:06 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:09:06 INFO - Cleaning up... 08:09:06 INFO - Return code: 0 08:09:06 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 08:09:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:06 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 0x7f862e2b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17356d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c4920>, '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 0x17c5820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c5cb0>, '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': '7de08804244eb36560b44971000001c3-1457712522.837059-206446385', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:09:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 08:09:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:09:06 INFO - Using env: {'DISPLAY': ':0', 08:09:06 INFO - 'HOME': '/home/cltbld', 08:09:06 INFO - 'LANG': 'en_US.UTF-8', 08:09:06 INFO - 'LANGUAGE': 'en_US:en', 08:09:06 INFO - 'LOGNAME': 'cltbld', 08:09:06 INFO - 'MAIL': '/var/mail/cltbld', 08:09:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:06 INFO - 'MOZ_NO_REMOTE': '1', 08:09:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:06 INFO - 'NO_EM_RESTART': '1', 08:09:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:09:06 INFO - 'PWD': '/builds/slave/test-pgo', 08:09:06 INFO - 'SHELL': '/bin/bash', 08:09:06 INFO - 'SHLVL': '1', 08:09:06 INFO - 'TERM': 'linux', 08:09:06 INFO - 'TMOUT': '86400', 08:09:06 INFO - 'USER': 'cltbld', 08:09:06 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1457712522.837059-206446385', 08:09:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:06 INFO - '_': '/tools/buildbot/bin/python'} 08:09:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:07 INFO - Downloading/unpacking psutil>=0.7.1 08:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 08:09:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:09:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:09:08 INFO - Installing collected packages: psutil 08:09:08 INFO - Running setup.py install for psutil 08:09:09 INFO - building 'psutil._psutil_linux' extension 08:09:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:09:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:09:09 INFO - building 'psutil._psutil_posix' extension 08:09:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:09:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:09:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:09:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:09:09 INFO - Successfully installed psutil 08:09:09 INFO - Cleaning up... 08:09:09 INFO - Return code: 0 08:09:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 08:09:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:09 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 0x7f862e2b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17356d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c4920>, '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 0x17c5820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c5cb0>, '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': '7de08804244eb36560b44971000001c3-1457712522.837059-206446385', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:09:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 08:09:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:09:09 INFO - Using env: {'DISPLAY': ':0', 08:09:09 INFO - 'HOME': '/home/cltbld', 08:09:09 INFO - 'LANG': 'en_US.UTF-8', 08:09:09 INFO - 'LANGUAGE': 'en_US:en', 08:09:09 INFO - 'LOGNAME': 'cltbld', 08:09:09 INFO - 'MAIL': '/var/mail/cltbld', 08:09:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:09 INFO - 'MOZ_NO_REMOTE': '1', 08:09:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:09 INFO - 'NO_EM_RESTART': '1', 08:09:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:09:09 INFO - 'PWD': '/builds/slave/test-pgo', 08:09:09 INFO - 'SHELL': '/bin/bash', 08:09:09 INFO - 'SHLVL': '1', 08:09:09 INFO - 'TERM': 'linux', 08:09:09 INFO - 'TMOUT': '86400', 08:09:09 INFO - 'USER': 'cltbld', 08:09:09 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1457712522.837059-206446385', 08:09:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:09 INFO - '_': '/tools/buildbot/bin/python'} 08:09:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:09 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:09:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:09:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:09:11 INFO - Installing collected packages: mozsystemmonitor 08:09:11 INFO - Running setup.py install for mozsystemmonitor 08:09:11 INFO - Successfully installed mozsystemmonitor 08:09:11 INFO - Cleaning up... 08:09:11 INFO - Return code: 0 08:09:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 08:09:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:11 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 0x7f862e2b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17356d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c4920>, '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 0x17c5820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c5cb0>, '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': '7de08804244eb36560b44971000001c3-1457712522.837059-206446385', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:09:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 08:09:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:09:11 INFO - Using env: {'DISPLAY': ':0', 08:09:11 INFO - 'HOME': '/home/cltbld', 08:09:11 INFO - 'LANG': 'en_US.UTF-8', 08:09:11 INFO - 'LANGUAGE': 'en_US:en', 08:09:11 INFO - 'LOGNAME': 'cltbld', 08:09:11 INFO - 'MAIL': '/var/mail/cltbld', 08:09:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:11 INFO - 'MOZ_NO_REMOTE': '1', 08:09:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:11 INFO - 'NO_EM_RESTART': '1', 08:09:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:09:11 INFO - 'PWD': '/builds/slave/test-pgo', 08:09:11 INFO - 'SHELL': '/bin/bash', 08:09:11 INFO - 'SHLVL': '1', 08:09:11 INFO - 'TERM': 'linux', 08:09:11 INFO - 'TMOUT': '86400', 08:09:11 INFO - 'USER': 'cltbld', 08:09:11 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1457712522.837059-206446385', 08:09:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:11 INFO - '_': '/tools/buildbot/bin/python'} 08:09:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:11 INFO - Downloading/unpacking blobuploader==1.2.4 08:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:13 INFO - Downloading blobuploader-1.2.4.tar.gz 08:09:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:09:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:09:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 08:09:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:14 INFO - Downloading docopt-0.6.1.tar.gz 08:09:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 08:09:14 INFO - Installing collected packages: blobuploader, requests, docopt 08:09:14 INFO - Running setup.py install for blobuploader 08:09:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:09:14 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 08:09:14 INFO - Running setup.py install for requests 08:09:15 INFO - Running setup.py install for docopt 08:09:15 INFO - Successfully installed blobuploader requests docopt 08:09:15 INFO - Cleaning up... 08:09:15 INFO - Return code: 0 08:09:15 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:09:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:15 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 0x7f862e2b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17356d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c4920>, '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 0x17c5820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c5cb0>, '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': '7de08804244eb36560b44971000001c3-1457712522.837059-206446385', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:09:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 08:09:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:09:15 INFO - Using env: {'DISPLAY': ':0', 08:09:15 INFO - 'HOME': '/home/cltbld', 08:09:15 INFO - 'LANG': 'en_US.UTF-8', 08:09:15 INFO - 'LANGUAGE': 'en_US:en', 08:09:15 INFO - 'LOGNAME': 'cltbld', 08:09:15 INFO - 'MAIL': '/var/mail/cltbld', 08:09:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:15 INFO - 'MOZ_NO_REMOTE': '1', 08:09:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:15 INFO - 'NO_EM_RESTART': '1', 08:09:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:09:15 INFO - 'PWD': '/builds/slave/test-pgo', 08:09:15 INFO - 'SHELL': '/bin/bash', 08:09:15 INFO - 'SHLVL': '1', 08:09:15 INFO - 'TERM': 'linux', 08:09:15 INFO - 'TMOUT': '86400', 08:09:15 INFO - 'USER': 'cltbld', 08:09:15 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1457712522.837059-206446385', 08:09:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:15 INFO - '_': '/tools/buildbot/bin/python'} 08:09:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:09:15 INFO - Running setup.py (path:/tmp/pip-VTFES8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:09:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:09:15 INFO - Running setup.py (path:/tmp/pip-KBdT6Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:09:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:09:15 INFO - Running setup.py (path:/tmp/pip-AOhbZX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:09:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:09:15 INFO - Running setup.py (path:/tmp/pip-3cs6Kr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:09:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:09:15 INFO - Running setup.py (path:/tmp/pip-oXmYHd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:09:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:09:15 INFO - Running setup.py (path:/tmp/pip-I_7P_u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:09:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:09:15 INFO - Running setup.py (path:/tmp/pip-08HWxd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:09:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:09:15 INFO - Running setup.py (path:/tmp/pip-JL1xqb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:09:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:09:16 INFO - Running setup.py (path:/tmp/pip-iVP3df-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:09:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:09:16 INFO - Running setup.py (path:/tmp/pip-BX3epq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:09:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:09:16 INFO - Running setup.py (path:/tmp/pip-J5dQUV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:09:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:09:16 INFO - Running setup.py (path:/tmp/pip-e5Fz3b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:09:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:09:16 INFO - Running setup.py (path:/tmp/pip-9hNeCy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:09:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:09:16 INFO - Running setup.py (path:/tmp/pip-b6eoHP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:09:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:09:16 INFO - Running setup.py (path:/tmp/pip-kQSyRb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:09:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:09:16 INFO - Running setup.py (path:/tmp/pip-e6SAWs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:09:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:09:16 INFO - Running setup.py (path:/tmp/pip-ZoFgEU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:09:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:09:16 INFO - Running setup.py install for manifestparser 08:09:16 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 08:09:16 INFO - Running setup.py install for mozcrash 08:09:16 INFO - Running setup.py install for mozdebug 08:09:16 INFO - Running setup.py install for mozdevice 08:09:17 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 08:09:17 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 08:09:17 INFO - Running setup.py install for mozfile 08:09:17 INFO - Running setup.py install for mozhttpd 08:09:17 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 08:09:17 INFO - Running setup.py install for mozinfo 08:09:17 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 08:09:17 INFO - Running setup.py install for mozInstall 08:09:17 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 08:09:17 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 08:09:17 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 08:09:17 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 08:09:17 INFO - Running setup.py install for mozleak 08:09:17 INFO - Running setup.py install for mozlog 08:09:17 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 08:09:17 INFO - Running setup.py install for moznetwork 08:09:17 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 08:09:17 INFO - Running setup.py install for mozprocess 08:09:17 INFO - Running setup.py install for mozprofile 08:09:17 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 08:09:17 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 08:09:17 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 08:09:18 INFO - Running setup.py install for mozrunner 08:09:18 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 08:09:18 INFO - Running setup.py install for mozscreenshot 08:09:18 INFO - Running setup.py install for moztest 08:09:18 INFO - Running setup.py install for mozversion 08:09:18 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 08:09:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:09:18 INFO - Cleaning up... 08:09:18 INFO - Return code: 0 08:09:18 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:09:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:18 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 0x7f862e2b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17356d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c4920>, '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 0x17c5820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c5cb0>, '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': '7de08804244eb36560b44971000001c3-1457712522.837059-206446385', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:09:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 08:09:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:09:18 INFO - Using env: {'DISPLAY': ':0', 08:09:18 INFO - 'HOME': '/home/cltbld', 08:09:18 INFO - 'LANG': 'en_US.UTF-8', 08:09:18 INFO - 'LANGUAGE': 'en_US:en', 08:09:18 INFO - 'LOGNAME': 'cltbld', 08:09:18 INFO - 'MAIL': '/var/mail/cltbld', 08:09:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:18 INFO - 'MOZ_NO_REMOTE': '1', 08:09:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:18 INFO - 'NO_EM_RESTART': '1', 08:09:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:09:18 INFO - 'PWD': '/builds/slave/test-pgo', 08:09:18 INFO - 'SHELL': '/bin/bash', 08:09:18 INFO - 'SHLVL': '1', 08:09:18 INFO - 'TERM': 'linux', 08:09:18 INFO - 'TMOUT': '86400', 08:09:18 INFO - 'USER': 'cltbld', 08:09:18 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1457712522.837059-206446385', 08:09:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:18 INFO - '_': '/tools/buildbot/bin/python'} 08:09:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:09:18 INFO - Running setup.py (path:/tmp/pip-R8oPlz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:09:18 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 08:09:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:09:18 INFO - Running setup.py (path:/tmp/pip-TINO2k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:09:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 08:09:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:09:18 INFO - Running setup.py (path:/tmp/pip-kqs04q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:09:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 08:09:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:09:18 INFO - Running setup.py (path:/tmp/pip-wemIXa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:09:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 08:09:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:09:18 INFO - Running setup.py (path:/tmp/pip-_3i1AT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:09:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 08:09:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:09:19 INFO - Running setup.py (path:/tmp/pip-3NDpFD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:09:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 08:09:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:09:19 INFO - Running setup.py (path:/tmp/pip-St_cJu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:09:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 08:09:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:09:19 INFO - Running setup.py (path:/tmp/pip-lxS511-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:09:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 08:09:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:09:19 INFO - Running setup.py (path:/tmp/pip-O_0R4Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:09:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 08:09:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:09:19 INFO - Running setup.py (path:/tmp/pip-2YbOMf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:09:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 08:09:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:09:19 INFO - Running setup.py (path:/tmp/pip-267gc9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:09:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 08:09:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:09:19 INFO - Running setup.py (path:/tmp/pip-OmHOPQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:09:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 08:09:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:09:19 INFO - Running setup.py (path:/tmp/pip-oTRM3e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:09:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 08:09:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:09:19 INFO - Running setup.py (path:/tmp/pip-goTO7I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:09:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 08:09:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:09:19 INFO - Running setup.py (path:/tmp/pip-p0xo0q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:09:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 08:09:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:09:19 INFO - Running setup.py (path:/tmp/pip-Wiy79z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:09:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 08:09:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:09:19 INFO - Running setup.py (path:/tmp/pip-gJLNaf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:09:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 08:09:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 08:09:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 08:09:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 08:09:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 08:09:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 08:09:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 08:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:21 INFO - Downloading blessings-1.6.tar.gz 08:09:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 08:09:21 INFO - Installing collected packages: blessings 08:09:21 INFO - Running setup.py install for blessings 08:09:21 INFO - Successfully installed blessings 08:09:21 INFO - Cleaning up... 08:09:21 INFO - Return code: 0 08:09:21 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 08:09:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:09:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:09:22 INFO - Reading from file tmpfile_stdout 08:09:22 INFO - Current package versions: 08:09:22 INFO - argparse == 1.2.1 08:09:22 INFO - blessings == 1.6 08:09:22 INFO - blobuploader == 1.2.4 08:09:22 INFO - docopt == 0.6.1 08:09:22 INFO - manifestparser == 1.1 08:09:22 INFO - mozInstall == 1.12 08:09:22 INFO - mozcrash == 0.17 08:09:22 INFO - mozdebug == 0.1 08:09:22 INFO - mozdevice == 0.48 08:09:22 INFO - mozfile == 1.2 08:09:22 INFO - mozhttpd == 0.7 08:09:22 INFO - mozinfo == 0.9 08:09:22 INFO - mozleak == 0.1 08:09:22 INFO - mozlog == 3.1 08:09:22 INFO - moznetwork == 0.27 08:09:22 INFO - mozprocess == 0.22 08:09:22 INFO - mozprofile == 0.28 08:09:22 INFO - mozrunner == 6.11 08:09:22 INFO - mozscreenshot == 0.1 08:09:22 INFO - mozsystemmonitor == 0.0 08:09:22 INFO - moztest == 0.7 08:09:22 INFO - mozversion == 1.4 08:09:22 INFO - psutil == 3.1.1 08:09:22 INFO - requests == 1.2.3 08:09:22 INFO - wsgiref == 0.1.2 08:09:22 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:09:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:22 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 0x7f862e2b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17356d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c4920>, '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 0x17c5820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c5cb0>, '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': '7de08804244eb36560b44971000001c3-1457712522.837059-206446385', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:09:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 08:09:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:09:22 INFO - Using env: {'DISPLAY': ':0', 08:09:22 INFO - 'HOME': '/home/cltbld', 08:09:22 INFO - 'LANG': 'en_US.UTF-8', 08:09:22 INFO - 'LANGUAGE': 'en_US:en', 08:09:22 INFO - 'LOGNAME': 'cltbld', 08:09:22 INFO - 'MAIL': '/var/mail/cltbld', 08:09:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:22 INFO - 'MOZ_NO_REMOTE': '1', 08:09:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:22 INFO - 'NO_EM_RESTART': '1', 08:09:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:09:22 INFO - 'PWD': '/builds/slave/test-pgo', 08:09:22 INFO - 'SHELL': '/bin/bash', 08:09:22 INFO - 'SHLVL': '1', 08:09:22 INFO - 'TERM': 'linux', 08:09:22 INFO - 'TMOUT': '86400', 08:09:22 INFO - 'USER': 'cltbld', 08:09:22 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1457712522.837059-206446385', 08:09:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:22 INFO - '_': '/tools/buildbot/bin/python'} 08:09:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 08:09:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 08:09:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 08:09:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 08:09:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 08:09:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 08:09:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 08:09:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 08:09:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 08:09:22 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 08:09:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 08:09:22 INFO - Cleaning up... 08:09:22 INFO - Return code: 0 08:09:22 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 08:09:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:22 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 0x7f862e2b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17356d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c4920>, '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 0x17c5820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c5cb0>, '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': '7de08804244eb36560b44971000001c3-1457712522.837059-206446385', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:09:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 08:09:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:09:22 INFO - Using env: {'DISPLAY': ':0', 08:09:22 INFO - 'HOME': '/home/cltbld', 08:09:22 INFO - 'LANG': 'en_US.UTF-8', 08:09:22 INFO - 'LANGUAGE': 'en_US:en', 08:09:22 INFO - 'LOGNAME': 'cltbld', 08:09:22 INFO - 'MAIL': '/var/mail/cltbld', 08:09:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:22 INFO - 'MOZ_NO_REMOTE': '1', 08:09:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:22 INFO - 'NO_EM_RESTART': '1', 08:09:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:09:22 INFO - 'PWD': '/builds/slave/test-pgo', 08:09:22 INFO - 'SHELL': '/bin/bash', 08:09:22 INFO - 'SHLVL': '1', 08:09:22 INFO - 'TERM': 'linux', 08:09:22 INFO - 'TMOUT': '86400', 08:09:22 INFO - 'USER': 'cltbld', 08:09:22 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1457712522.837059-206446385', 08:09:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:22 INFO - '_': '/tools/buildbot/bin/python'} 08:09:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:22 INFO - Downloading/unpacking jsonschema 08:09:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:09:24 INFO - Downloading/unpacking functools32 (from jsonschema) 08:09: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 08:09: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 08:09: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 08:09: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 08:09: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 08:09: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 08:09:24 INFO - Downloading functools32-3.2.3-2.tar.gz 08:09:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 08:09:24 INFO - warning: no files found matching '*.txt' 08:09:24 INFO - no previously-included directories found matching 'build' 08:09:24 INFO - no previously-included directories found matching 'dist' 08:09:24 INFO - no previously-included directories found matching '.git*' 08:09:24 INFO - Installing collected packages: jsonschema, functools32 08:09:24 INFO - Running setup.py install for functools32 08:09:25 INFO - warning: no files found matching '*.txt' 08:09:25 INFO - no previously-included directories found matching 'build' 08:09:25 INFO - no previously-included directories found matching 'dist' 08:09:25 INFO - no previously-included directories found matching '.git*' 08:09:25 INFO - Successfully installed jsonschema functools32 08:09:25 INFO - Cleaning up... 08:09:25 INFO - Return code: 0 08:09:25 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 08:09:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:25 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 0x7f862e2b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17356d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c4920>, '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 0x17c5820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c5cb0>, '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': '7de08804244eb36560b44971000001c3-1457712522.837059-206446385', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:09:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 08:09:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:09:25 INFO - Using env: {'DISPLAY': ':0', 08:09:25 INFO - 'HOME': '/home/cltbld', 08:09:25 INFO - 'LANG': 'en_US.UTF-8', 08:09:25 INFO - 'LANGUAGE': 'en_US:en', 08:09:25 INFO - 'LOGNAME': 'cltbld', 08:09:25 INFO - 'MAIL': '/var/mail/cltbld', 08:09:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:25 INFO - 'MOZ_NO_REMOTE': '1', 08:09:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:25 INFO - 'NO_EM_RESTART': '1', 08:09:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:09:25 INFO - 'PWD': '/builds/slave/test-pgo', 08:09:25 INFO - 'SHELL': '/bin/bash', 08:09:25 INFO - 'SHLVL': '1', 08:09:25 INFO - 'TERM': 'linux', 08:09:25 INFO - 'TMOUT': '86400', 08:09:25 INFO - 'USER': 'cltbld', 08:09:25 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1457712522.837059-206446385', 08:09:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:25 INFO - '_': '/tools/buildbot/bin/python'} 08:09:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:25 INFO - Downloading/unpacking flake8 08:09:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:09:27 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:27 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:09:27 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 08:09:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:09:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:09:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:09:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:09:27 INFO - no previously-included directories found matching 'docs/_build' 08:09:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:09:27 INFO - Running setup.py install for pep8 08:09:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:09:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:09:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:09:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:09:27 INFO - no previously-included directories found matching 'docs/_build' 08:09:28 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 08:09:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:09:28 INFO - Cleaning up... 08:09:28 INFO - Return code: 0 08:09:28 INFO - Running post-action listener: _resource_record_post_action 08:09:28 INFO - Running post-action listener: _start_resource_monitoring 08:09:28 INFO - Starting resource monitoring. 08:09:28 INFO - ##### 08:09:28 INFO - ##### Running install step. 08:09:28 INFO - ##### 08:09:28 INFO - Running pre-action listener: _resource_record_pre_action 08:09:28 INFO - Running main action method: install 08:09:28 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:09:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:09:28 INFO - Reading from file tmpfile_stdout 08:09:28 INFO - Detecting whether we're running mozinstall >=1.0... 08:09:28 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 08:09:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 08:09:28 INFO - Reading from file tmpfile_stdout 08:09:28 INFO - Output received: 08:09:28 INFO - Usage: mozinstall [options] installer 08:09:28 INFO - Options: 08:09:28 INFO - -h, --help show this help message and exit 08:09:28 INFO - -d DEST, --destination=DEST 08:09:28 INFO - Directory to install application into. [default: 08:09:28 INFO - "/builds/slave/test-pgo"] 08:09:28 INFO - --app=APP Application being installed. [default: firefox] 08:09:28 INFO - mkdir: /builds/slave/test-pgo/build/application 08:09:28 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 08:09:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 08:09:44 INFO - Reading from file tmpfile_stdout 08:09:44 INFO - Output received: 08:09:44 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 08:09:44 INFO - Running post-action listener: _resource_record_post_action 08:09:44 INFO - ##### 08:09:44 INFO - ##### Running run-tests step. 08:09:44 INFO - ##### 08:09:44 INFO - Running pre-action listener: _resource_record_pre_action 08:09:44 INFO - Running main action method: run_tests 08:09:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 08:09:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 08:09:44 INFO - Python 2.7.3 08:09:44 INFO - Return code: 0 08:09:44 INFO - grabbing minidump binary from tooltool 08:09:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:44 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 0x17c4920>, '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 0x17c5820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c5cb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 08:09:44 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 08:09:44 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:09:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:09:44 INFO - Return code: 0 08:09:44 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 08:09:44 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 08:09:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 08:09:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 08:09:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 08:09:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 08:09:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 08:09:45 INFO - Return code: 0 08:09:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EymNfJgBS76aErO5LXsoig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 08:09:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EymNfJgBS76aErO5LXsoig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 08:09:45 INFO - Using env: {'DISPLAY': ':0', 08:09:45 INFO - 'HOME': '/home/cltbld', 08:09:45 INFO - 'LANG': 'en_US.UTF-8', 08:09:45 INFO - 'LANGUAGE': 'en_US:en', 08:09:45 INFO - 'LOGNAME': 'cltbld', 08:09:45 INFO - 'MAIL': '/var/mail/cltbld', 08:09:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:09:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 08:09:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:45 INFO - 'MOZ_NO_REMOTE': '1', 08:09:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:09:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:45 INFO - 'NO_EM_RESTART': '1', 08:09:45 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:09:45 INFO - 'PWD': '/builds/slave/test-pgo', 08:09:45 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 08:09:45 INFO - 'SHELL': '/bin/bash', 08:09:45 INFO - 'SHLVL': '1', 08:09:45 INFO - 'TERM': 'linux', 08:09:45 INFO - 'TMOUT': '86400', 08:09:45 INFO - 'USER': 'cltbld', 08:09:45 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1457712522.837059-206446385', 08:09:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:45 INFO - '_': '/tools/buildbot/bin/python'} 08:09:45 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EymNfJgBS76aErO5LXsoig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:09:45 INFO - mozversion application_buildid: 20160311053012 08:09:45 INFO - mozversion application_changeset: 7feee955891b1a600f78541e69e0e6a72b32cfc4 08:09:45 INFO - mozversion application_display_name: Nightly 08:09:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:09:45 INFO - mozversion application_name: Firefox 08:09:45 INFO - mozversion application_remotingname: firefox 08:09:45 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:09:45 INFO - mozversion application_vendor: Mozilla 08:09:45 INFO - mozversion application_version: 48.0a1 08:09:45 INFO - mozversion platform_buildid: 20160311053012 08:09:45 INFO - mozversion platform_changeset: 7feee955891b1a600f78541e69e0e6a72b32cfc4 08:09:45 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:09:45 INFO - mozversion platform_version: 48.0a1 08:09:45 INFO - using testdate: 1457712585 08:09:45 INFO - actual date: 1457712585 08:09:45 INFO - starting webserver on 'localhost:33603' 08:09:45 INFO - SUITE-START | Running 2 tests 08:09:45 INFO - TEST-START | dromaeo_css 08:09:45 INFO - operating with platform_type : linux_ 08:09:45 INFO - Initialising browser for dromaeo_css test... 08:09:45 INFO - TEST-INFO | started process 1269 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHIX4j7/profile http://localhost:33603/getInfo.html) 08:09:50 INFO - PROCESS | 1269 | __metrics Screen width/height:1600/1200 08:09:50 INFO - PROCESS | 1269 | colorDepth:24 08:09:50 INFO - PROCESS | 1269 | Browser inner width/height: 1024/697 08:09:50 INFO - PROCESS | 1269 | __metrics 08:09:51 ERROR - PROCESS | 1269 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:09:51 INFO - PROCESS | 1269 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 08:09:52 INFO - TEST-INFO | 1269: exit 0 08:09:52 INFO - Browser initialized. 08:09:52 INFO - Running cycle 1/1 for dromaeo_css test... 08:09:52 INFO - TEST-INFO | started process 1362 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHIX4j7/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:10:04 INFO - PROCESS | 1362 | RSS: Main: 154259456 08:10:04 INFO - PROCESS | 1362 | 08:10:55 INFO - PROCESS | 1362 | 1457712655704 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:13:03 INFO - PROCESS | 1362 | Cycle 1(1): loaded http://localhost:33603/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33603/tests/dromaeo/cssquery-ext.html) 08:13:04 INFO - PROCESS | 1362 | RSS: Main: 246153216 08:13:04 INFO - PROCESS | 1362 | 08:16:06 INFO - PROCESS | 1362 | Cycle 1(1): loaded http://localhost:33603/tests/dromaeo/cssquery-ext.html (next: http://localhost:33603/tests/dromaeo/cssquery-jquery.html) 08:16:07 INFO - PROCESS | 1362 | RSS: Main: 234778624 08:16:07 INFO - PROCESS | 1362 | 08:19:09 INFO - PROCESS | 1362 | Cycle 1(1): loaded http://localhost:33603/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33603/tests/dromaeo/cssquery-mootools.html) 08:19:09 INFO - PROCESS | 1362 | RSS: Main: 237654016 08:19:09 INFO - PROCESS | 1362 | 08:22:11 INFO - PROCESS | 1362 | Cycle 1(1): loaded http://localhost:33603/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33603/tests/dromaeo/cssquery-prototype.html) 08:22:12 INFO - PROCESS | 1362 | RSS: Main: 216535040 08:22:12 INFO - PROCESS | 1362 | 08:25:14 INFO - PROCESS | 1362 | Cycle 1(1): loaded http://localhost:33603/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33603/tests/dromaeo/cssquery-yui.html) 08:25:15 INFO - PROCESS | 1362 | RSS: Main: 217890816 08:25:15 INFO - PROCESS | 1362 | 08:28:18 INFO - PROCESS | 1362 | Cycle 1(1): loaded http://localhost:33603/tests/dromaeo/cssquery-yui.html (next: http://localhost:33603/tests/dromaeo/cssquery-dojo.html) 08:28:18 INFO - PROCESS | 1362 | RSS: Main: 297082880 08:28:18 INFO - PROCESS | 1362 | 08:28:18 INFO - PROCESS | 1362 | __start_tp_report 08:28:18 INFO - PROCESS | 1362 | _x_x_mozilla_page_load 08:28:18 INFO - PROCESS | 1362 | _x_x_mozilla_page_load_details 08:28:18 INFO - PROCESS | 1362 | |i|pagename|runs| 08:28:18 INFO - PROCESS | 1362 | |0;dojo.html;3128.171034675811;3192.2817366092618;3222.4038552867723;3223.016979821155;3256.5603643508125;4986.252062190673;5122.513361230686;5137.871553211172;5143.408508021574;5198.142306519425;5078.949210507893;5155.355580552431;5158.071547121526;5198.350206224222;5219.973900130494;4564.7945842437;4638.652101092414;4668.6731928765;4675.4155730533685;4749.026449577846;4688.671792974493;4704.341392205094;4732.1482133216;4753.595944344735;4790.353302304179;4573.245414506602;4668.533146685339;4679.415073115861;4720.527947205286;4753.71477711335;4692.95307046932;4703.2709929960565;4705.976470117662;4733.881652958704;4737.786799593992;4609.700369476007;4693.272542755878;4702.976485117552;4733.644976626767;4756.334113224151;4805.231163013901;4859.392575928009;4859.927101093486;4875.414950205998;4909.7790599423115;5457.727113644302;5470.91793623096;5471.863203419906;5474.2609747683955;5527.309086364205;5379.677219366811;5467.234587157761;5495.477929596722;5525.364583072957;5544.390117087158;5196.0647083524955;5198.194279886624;5216.347956505437;5231.110711179109;5262.657927234717;5666.688332141772;5670.8015219467125;5679.148127780783;5679.290088738908;5694.886102277931;5257.684538927677;5407.297051383295;5415.5938304626525;5432.864178395572;5453.345598528202;5532.059549876451;5551.7779288828;5554.361248456479;5557.3886872444;5567.972160139255;5522.30971128609;5529.115341545414;5541.556675465953;5543.196236545678;5546.223528705985;5250.501202385767;5512.80705175317;5557.277553917965;5587.27365442498;5610.663360198401;4227.894302642397;4228.703990720682;4229;4237.809298581509;4270.0605866709275;3835.6547910687614;3847.03824043989;3853.7302388833073;3856.7107466940092;3866.516685414323;5004.424491183488;5095.77069031887;5218.843434696965;5240.947590524046;5245.895082098413;5464.836054918279;5477.507024367826;5481.698506582176;5489.917651235235;5495.945040549544;5154.819581314636;5175.094358487249;5183.792648294101;5185.403678576937;5189.117849965515;4510.954890451119;4653.906921861544;4727.64542659302;4744.715317080986;4749.168895443284;5692.14617807324;5697.173909783141;5708.372079071299;5710.057840456361;5714.885702286014;5334.333208348957;5406.216098665593;5414.0796064669885;5414.3232095988005;5458.727063646881;5786.450287222707;5849.8537536560225;5857.58996870232;5883.264591926009;5886.323072846506;5383.569314454756;5387.676739395492;5388.057090009311;5389.056915039774;5392.676439413648;5337.172738225581;5436.891262174813;5445.945540544544;5449.509544141047;5496.120620700669;5384.515393614593;5424.837254882202;5425.21334406501;5469.288992430958;5474.753636086306;5351.625386223082;5386.865328366822;5389.62272640927;5398.7300634967305;5407.594430417813;5106.336176297206;5193.68837869729;5270.973645131749;5279.894402112013;5357.785688572413;5284.180951952453;5335.813246536352;5354.866128346823;5381.354237491526;5397.190421436659;5231.607629427732;5240.947590524046;5241.187615919539;5243.711595862264;5244.187150991603 08:28:18 INFO - PROCESS | 1362 | |1;ext.html;506.7289000384795;532.3771187710379;544.0723566319423;558.9659130608375;592.4312659846547;28728.71271287289;36941.81529092354;37037.81481092598;37097.25805483895;37147;40525.39211911824;41111.17777644453;41116.38325425121;41159.58840411595;41222.7938860306;7450.813729656775;7640.656170472342;7642.121156067068;8453.619587118594;8692.739217823475;10246;10448.477576121164;10505.107065899409;10510.474476276193;10520.947395263012;10232.386056836576;10339.483025848715;10349.896501035006;10353.482325883713;10354.896451035469;10056.89943100567;10161.187105031617;10161.59353625854;10171.64399246023;10175;10023.849642255373;10140.746481337952;10152.847707284396;10159.390436573829;10166.542505587193;41450.37824432636;41488.792556037326;41691.7915410424;41799.16401671949;41896.58103418957;3347.548081009081;3358.4458564336855;3515.209077957439;3565.447355659877;3808.390657494815;31648.208794780083;31869.813018698176;31873.203169920707;32149;33180.668193318;4004.6395824375945;4043.858464953742;4062.2484840304637;4067.3085575452246;4114.876553703393;282311;283230;283886.99999999796;283917;284983;60861;61083;61443.38556614466;61482.385176148564;61528.38471615316;67877;69417.65291173512;69461;69511.65244173747;69587;15864.841351586567;16016.199190040452;16080.517584472485;16106.114163720873;16115.919420402823;12053.63839084829;12166.756664866652;12166.81749773754;12167.878321216851;12174;20526.17895284202;20749.68875466839;20903.68644470334;20925.37223883286;21538.676919846213;7913.287804097658;8073.7577872663915;8142.4300298978505;8246.175382461706;8260.628271727786;914.9954250228707;928.6935311347239;1064.1274155192668;1065.0840277361463;1070.2936062198912;29495;29503.55744663832;29628.965139168962;29785.702142978727;30036.249093772392;871.4379225399582;980.3823591137681;1035.699647102332;1073.8013467508536;1122.259308856151;14085.577432677037;14093.85906140946;14172.787408188886;14246.07400518963;14375.424983000772;324339;325726;329053;329844;330064;52243.21635175475;53772.462275377526;53802;53846.19230711542;54099.45900541023;1126.14975693351;1226.178460431513;1304.243538747524;1350.0549615269351;1355.1665725578698;26455.60316595214;27094.864525677247;27187.32031699144;27614.44771104607;27808.721912780613;39507.802460987514;39758.60241397549;39831.80084099561;39841.60158398495;39904;182725;184073;186301;186331;194648.37461377567;28172;32066.839665801523;32579.18552036218;32879.8356008228;33186;39767;42365.36451953161;42728.78635606802;42774.572254278304;48661;37326.44010339793;37448.62551374451;37595;38459;39462.40806387849;37809.68552334965;38375.80812095922;38576;38760.61239387683;38775.61224387833;36833;36991.07522311964;37569.2486150281;37585.2482950334;37737.433938490394;32061.51907721433;33052.33895322032;33283.50074748929;33664;33879;25651.743482565682;25864.612030819175;25938.740612593632;26443.471130576894;26460 08:28:18 INFO - PROCESS | 1362 | |2;jquery.html;341.5696222759323;357.91767893384537;364.3769154745385;370.6090074970905;370.86463440844085;16255.943363681366;16874.578135546617;17782.466526004224;18195.272189112453;18241.270349186016;11292.830607540873;11589.130815188852;11608.883911160885;11613.941930290357;16668.416605418814;5009.599232061444;5046.646734728571;5162.483751624826;5181.481851814826;5186.273921650972;5120;5144.4598317176715;5163.561097306733;5164.92252616211;5165.3026841376495;5133.383993920716;5135.460776618457;5148.871278218037;5156.53591176794;5230.137027390476;5158.638895277332;5585.916211256835;5601.103823388259;5606.747696353674;5623.409541998072;5019.171836646949;5033.546980771712;5040.143175660147;5044.218146187347;5045.722485263309;19858.70211946822;20164.495887602927;20580.27969021077;20672.689909651366;20751.792482075136;1947.6883698608156;2047.1624773257392;2074.481379655086;2209.215728416405;2216.601011817872;8961.238294744955;10087.445190514518;10773.946130269298;11316.830247546211;13592.25242611656;1850.5558665920216;1864.5152260412256;1902.4197619725978;1957.412776167144;1987.8409727221933;48906;57687.13469297922;59497;59877;66410.3358966409;9753.756156096155;9946.950265248628;10638.893611063944;10664.733381665521;10866.61966831157;14098.577042688736;14218.075825071544;14225.075370101118;14235.501757438647;14249.216293103771;7189.96405017982;7733.651985660659;7755.72854950074;7819.0617125945255;7824.178461261599;7368.042154519878;7410.296021877913;7513.248675132443;7528;7542.811429714301;4311.439512863308;4404.61254704767;4421.557844215553;4469.262571675637;4472.060867217856;1782.857371410284;1831.111910723298;1848.8613353998503;1882.7552418185821;1908.7327774111636;874.6151693254948;884.893812742475;914.6432891172448;983.4197823284154;1035.420164707751;16658.750118748227;16678.249478773483;17186.570335741708;17445.912770436065;17906;918.3342076994126;934.4393363981693;960.159860122393;966.5988614724811;996.6960077176531;9582.712518624452;9754.658586949423;9881.654142104991;10241.334313269763;10625.734356641145;459149;472339;474719;476517;477740;75296;77765.61117194378;78013.2198678006;78166;78268.60865695635;1035.6064695415694;1068.124138206663;1081.2485322700804;1084.793889161041;1090.8091084060259;14952.252387380806;15133.470328538448;15220.847791521943;15293.158876261912;15631.452899148475;32892.34215315728;33035.504467432525;33074.503882442266;34204.82897585496;34368.48447273243;45390.54609453863;45713.31430028619;51076.48923510866;51165;51444.48555514397;8407.201315874981;8408;8419.747407577783;8541.676040213777;8678;8828.558572071242;9723.076307750753;10591.788164236517;13018.739625207632;13362.866371336162;10746.785064298827;11000.559977600806;11137.665870023913;11561.42192890369;11573.88426115728;10627;11153.665390038312;11269.830952535554;11341.943290283496;11449.59926402572;11137.944310278397;11297.209195356574;11504.654860354203;11625.534978600761;11699.88300116988;8279.10881885513;8281.792955176168;8335.249827515552;8451.323894088335;8710.782230444289;10737.194710396596;11500.539978401104;11592.304461732323;11613.6515904523;11830.763384732085 08:28:18 INFO - PROCESS | 1362 | |3;mootools.html;1363.747706674266;1471.389373410035;1475.7343678137934;1641.679872424877;1801.2524802207076;7042;7160.28397160285;7175.60534170621;7176.246494118121;7180.389666878308;7441.888371674429;7599.392048636109;7615.657295421705;7619.619019049053;7620.276073772997;1932.2271091563416;1983.2959299448705;2206.2278202629113;2284.999999999996;2321.431249343913;2241.529278851443;2251.6284813005836;2255.6278214094655;2270.6139956207485;2273.022600281878;2208.7791220877866;2235.307054813013;2240.9551808963893;2278.0773786616364;2278.305116939333;2217.2904670505445;2225.9109635614554;2226.6103431899514;2227.94430139247;2230.152542034025;2236.3067449090836;2239.1267405711787;2241.081156725751;2256.0975609756065;2260.42359198405;7644.770656880302;7690.730824421118;7696.538207707499;7705.807354816175;7712.305892469704;4609.469910960215;4720.480747117815;4748.169070412699;4752.6910750801435;4763.428388593391;3114.5016797312323;3178;3279.770416070876;3283.7865538739907;3313.4698448248164;1079.4602698650674;1092.9071028962549;1102.1568500097433;1124.831275308702;1131.264677959333;10609.787804243872;10616.097631701316;10627.628033018884;10644.946775266151;10646.946765266124;4182.456280683492;4253.3194688849635;4326.264535029052;4331.523532411432;4332.696711230246;9039.367244292967;9063.365564410427;9068.773280667903;9082.954585227164;9119.81760364789;4718.811247550128;4729.07782982322;4731.266653668687;4732.313814496879;4735.550122738403;3740.7007439404783;3794.051487128218;4207.768572728468;4312.870613881589;4315.374270730789;3628.4738712886483;3658.762180458262;3698.223373091681;3706.1475860552223;3733.104055026774;1175.841261429713;1183.7024742462793;1191.3149938785234;1204.1209916760813;1223.2782658231686;1361.9387127579282;1380.496118916588;1396.0855639556107;1401.2643362234908;1405.6766943602825;7114.64426778659;7274.927250727531;7287.161976372785;7289.599072051088;7305.561666300039;476.797361121522;490.2132078014806;491.52322247419943;495.6951474842946;496.72431800351154;5646.20953066571;5674.460926212003;5705.657660540381;5714.657120572696;5730.914036289459;8420.789480263042;8810.295176385875;8826.249768769727;8884.911150888538;8952.283817294601;8756.912430875736;8779.165979231962;8840.690575829944;8841.292696584258;8850.557472126367;6934.653267336613;6976.232614412411;7026.683799229047;7033.050538177281;7052.858942821217;6771.966140169267;6795.3204679531655;6817.693203805741;6830.59016459014;6830.965845170742;7772.1450640428375;7964.6415911282975;8029.799255018671;8038.87941680887;8069.394795390252;8002.119766825528;8197.262246397853;8205.712800052208;8289.378296627898;8298.128696487023;6589.24223714279;6595.406413422815;6640.468762498892;6831.248562658005;6835.453163746789;7183.317584829433;7196.352328290479;7207.387372073433;7217.6030318330895;7248.311410416002;6582.670866456562;6657.101291325803;6695.096162018065;6746.696398661974;6828.7268509259075;6629.270780214076;6678.7328506859185;6688.632125233159;6722.731090756511;6730.192376914802;6775.830604234933;6849.554778939353;6881.759138430131;6888.173419189528;6890.31096890307;6341.048842673636;6406.455451286693;6409.935900640934;6410.935890641033;6413.647249401328;6402.167718196604;6430;6467.708953097028;6481.319461456479;6490.837729056811 08:28:18 INFO - PROCESS | 1362 | |4;prototype.html;333.5080755885068;334.2462746506627;335.7800640580418;339.5365326329561;340.57938446019165;5849.707514624262;5875.059990401536;5902.232709747732;5908.881822363555;5912.9704351478185;5812.738426770795;5871.119332100187;5872.7944521941745;5874.3244526879425;5874.5594080443925;4365.519792822787;4478.395416618748;4507.076049409863;4574.83988060418;4596.6322694184555;4601.401817763686;4606.009707912798;4615.3077038444335;4617.584417402433;4621.329907163459;4565.520620334867;4565.954340456603;4566.862994110165;4568.680192386534;4579.816807327703;4329.112531930947;4424.9557504424865;4564.109998550284;4571.314302854598;4571.817127314904;4026.6577340925764;4027.1140349123148;4029.8992525186814;4037.414574886625;4039.7576145431367;5591.580631452657;5609.186667933127;5611.887762244733;5615.2700148980775;5618.269624948772;5307.416184219733;5318.282031925679;5323.307969963918;5324;5326.067938110854;6233.906491402633;6252.812415627538;6302.4958003359625;6305.747770089191;6316.08416779569;4169.854055108087;4353.869383918487;4371.956280437187;4475.910481790346;4488.910221795579;6450.290468048511;6494.155759751202;6514.44627206688;6520.869582608321;6533.836654083639;4438.467383913951;4442.355858400514;4443.533428989909;4443.666724995638;4447;4486.506484286726;4487.371767952489;4488.506264310923;4490.820367185276;4492.3710680504755;5198;5205.24523944026;5206.713630750345;5208;5219.530242278213;6047.78832740852;6271.749130034747;6284.622922624566;6288.5283603728985;6295.937040629627;1540.3299564689396;1564.4837203722743;1578.8263291037977;1579.0920220873045;1582.2405245482232;972.7908499672604;1003.3428104591504;1032.1897310611134;1041.656253436364;1067.3969207397795;5901.468867801833;5904.261967254093;5914.408559144051;5915.733791979371;5920.881582368328;6391.552591318656;6405.743770249231;6410.8717825643225;6411.519136064814;6411.6153030818305;5956.970215148896;5968.820935371946;5974.3428222895445;5980.760769569169;5987.161797348374;3386.559747232844;3416.8804091857164;3422.6748458896363;3425.6403077676982;3426.931461370759;6605.07528945948;6746.257911629717;6758.628275444898;6763.5265531413315;6774.695138718671;6501.47988160946;6521.108878425299;6526.379993900572;6527.15147030883;6536.901946470807;6748.628825414551;6753.898691519631;6762.797116086525;6838.521303508806;6839.760608378683;6388.968055159695;6394.680265986589;6397.040443933447;6398.648074355769;6401.3598640135615;6174.969125154345;6332.778352757631;6336.809895703136;6346.270178929482;6346.619202847844;6722.2605513394465;6740.561863478858;6755.6622168892345;6757.290484499057;6759.898601520883;4442.6890117691455;4447.488538817948;4448.799804008762;4449.488308844395;4451.554844515523;6373.521985850987;6374.617522948638;6381.425671689571;6383.712732926937;6384.553081284451;6195.628262304276;6195.783147589813;6196.318404975359;6204.13142160089;6215.564910456224;6052.425019623129;6214.627122372672;6216.44052035319;6225.719842607003;6227;6077.604955677867;6097.993831017832;6099.390060994043;6103.511719062376;6117.632942023492;6237.126802247598;6237.282712488122;6240.53196010292;6240.937590624036;6247.09417134522;5908.556858235564;6008.789692360747;6090.573659843945;6098.146259523582;6101.6644084574 08:28:18 INFO - PROCESS | 1362 | |5;yui.html;722.5014739829518;724.1455083002057;756.795665170404;824.9793755156124;842.2209456252968;12845.100842940998;12954.222746635209;12998.15511991721;13003.089783715144;13019.739605207902;12852.421641026152;13239.271840048817;13258.668533286673;13264;13435.395407206675;820.5979070255577;827.5365795154703;832.1719888710742;834.1616675241374;835.419383528448;819.700809204639;827.4745536584282;827.6896163938524;828.7638023163399;829.5686243153557;868.7046404222563;868.8175483148547;869.4739682492096;871.9346049046347;874.1608056265992;867.3451544084239;868.0364795077459;869.9864657673802;870.3124531620012;871.1071152069117;640.1198352265635;640.5196102922808;640.5900223856736;643.7296335539085;645.5674697952384;11938.22401543897;12032.879671203264;12039.699007524794;12082.093842961813;12109.212901161485;11527.19309648325;11535.59625413115;11654.242474239232;11658;11671.1830171888;9376.203022743006;9635.90364096357;9876.35803672766;11816.940915295454;12117.091218158585;4312.137572485484;4328.43730315057;4389.2318844202455;4474.418325617681;4523.909521809545;48543.75728121372;50409.219308552005;50863;50901.490985090044;50959;9412.764680882896;9415.764605884771;9598.944116147219;9768.804623907483;10042.849357259647;17799.644007119787;17847.28610855577;17882.821171788375;17904.373346932796;17941.551461213312;7560.508566943131;7607.35337496319;7721.729739459204;7726.38188944883;8047.396445266629;4562.703424277478;4641.489436162019;4661.86014419568;4737.95262047382;4928.408590969107;3087.1356020314347;3106.39425312062;3118.3139709263924;3127.859246333875;3141.3403185331335;592.2389729198046;595.9150026567901;597.5996082624652;603.8218725475995;605.7970579855797;486.33615115367974;618.5608218165153;636.6784773689258;638.5913015669975;662.8144119646506;8700.52147131901;8821.911780882238;8847.690330838519;8896.8665470018;8902.109789021175;625.7321214098216;631.6904716688789;635.4376376906471;665.70043480434;674.254948282151;4025.1345960618023;4052.9594704052583;4140.772257525865;4186.665066794649;4265.872023839228;61477.31533558305;63767;64648.35351646518;64748;64764.67617661976;48460.515394846305;48504.27243591349;49801.750991244815;54268.45731542713;54457;45178.32232516515;47516.5248347519;47570.28644570334;48149.27776083362;48354;8697.913020869963;8742.912570874465;8832.160944710242;9038.819223615623;9055.36612437123;34666;34782.304353913285;35026.299474009866;35028.12429689278;36083.63916360908;41741;42384.78807605942;42766.57233427626;47127.293090604355;47144.52855471538;11184.664460066211;11200.271982321448;11395.829062563902;11665.941670291595;11762.823557646814;12136.878631213927;12357;12364.690882727644;12851.228926264454;12875.549355772877;11132.619135574436;11226.719332016764;11655;11671.824922626338;11691;10814.243002989715;10839.729006774895;11109.777804444027;11761.117916156494;11842.637692019483;11486.310821350746;11763.705907352385;11789.351585662527;11877.465514051715;12099.33453660057;10086.243531735296;10410.947945260225;10497.895021049997;10587.153027757608;10723;9480.445645777469;9675.433632184571;9832.410055396698;10114.949425252827;10335.328203666737 08:28:18 INFO - PROCESS | 1362 | __end_tp_report 08:28:18 INFO - PROCESS | 1362 | __start_cc_report 08:28:18 INFO - PROCESS | 1362 | _x_x_mozilla_cycle_collect,772 08:28:18 INFO - PROCESS | 1362 | __end_cc_report 08:28:18 INFO - PROCESS | 1362 | __startTimestamp1457713698292__endTimestamp 08:28:18 INFO - PROCESS | 1362 | 08:28:18 INFO - PROCESS | 1362 | ------- Summary: start ------- 08:28:18 INFO - PROCESS | 1362 | Number of tests: 6 08:28:18 INFO - PROCESS | 1362 | 08:28:18 INFO - PROCESS | 1362 | [#0] dojo.html Cycles:165 Average:5112.38 Median:5257.68 stddev:551.63 (10.5%) stddev-sans-first:530.91 08:28:18 INFO - PROCESS | 1362 | Values: 3128.2 3192.3 3222.4 3223.0 3256.6 4986.3 5122.5 5137.9 5143.4 5198.1 5078.9 5155.4 5158.1 5198.4 5220.0 4564.8 4638.7 4668.7 4675.4 4749.0 4688.7 4704.3 4732.1 4753.6 4790.4 4573.2 4668.5 4679.4 4720.5 4753.7 4693.0 4703.3 4706.0 4733.9 4737.8 4609.7 4693.3 4703.0 4733.6 4756.3 4805.2 4859.4 4859.9 4875.4 4909.8 5457.7 5470.9 5471.9 5474.3 5527.3 5379.7 5467.2 5495.5 5525.4 5544.4 5196.1 5198.2 5216.3 5231.1 5262.7 5666.7 5670.8 5679.1 5679.3 5694.9 5257.7 5407.3 5415.6 5432.9 5453.3 5532.1 5551.8 5554.4 5557.4 5568.0 5522.3 5529.1 5541.6 5543.2 5546.2 5250.5 5512.8 5557.3 5587.3 5610.7 4227.9 4228.7 4229.0 4237.8 4270.1 3835.7 3847.0 3853.7 3856.7 3866.5 5004.4 5095.8 5218.8 5240.9 5245.9 5464.8 5477.5 5481.7 5489.9 5495.9 5154.8 5175.1 5183.8 5185.4 5189.1 4511.0 4653.9 4727.6 4744.7 4749.2 5692.1 5697.2 5708.4 5710.1 5714.9 5334.3 5406.2 5414.1 5414.3 5458.7 5786.5 5849.9 5857.6 5883.3 5886.3 5383.6 5387.7 5388.1 5389.1 5392.7 5337.2 5436.9 5445.9 5449.5 5496.1 5384.5 5424.8 5425.2 5469.3 5474.8 5351.6 5386.9 5389.6 5398.7 5407.6 5106.3 5193.7 5271.0 5279.9 5357.8 5284.2 5335.8 5354.9 5381.4 5397.2 5231.6 5240.9 5241.2 5243.7 5244.2 08:28:18 INFO - PROCESS | 1362 | 08:28:18 INFO - PROCESS | 1362 | [#1] ext.html Cycles:180 Average:44701.17 Median:181558.17 stddev:71274.72 (39.3%) stddev-sans-first:71397.42 08:28:18 INFO - PROCESS | 1362 | Values: 506.7 532.4 544.1 559.0 592.4 28728.7 36941.8 37037.8 37097.3 37147.0 40525.4 41111.2 41116.4 41159.6 41222.8 7450.8 7640.7 7642.1 8453.6 8692.7 10246.0 10448.5 10505.1 10510.5 10520.9 10232.4 10339.5 10349.9 10353.5 10354.9 10056.9 10161.2 10161.6 10171.6 10175.0 10023.8 10140.7 10152.8 10159.4 10166.5 41450.4 41488.8 41691.8 41799.2 41896.6 3347.5 3358.4 3515.2 3565.4 3808.4 31648.2 31869.8 31873.2 32149.0 33180.7 4004.6 4043.9 4062.2 4067.3 4114.9 282311.0 283230.0 283887.0 283917.0 284983.0 60861.0 61083.0 61443.4 61482.4 61528.4 67877.0 69417.7 69461.0 69511.7 69587.0 15864.8 16016.2 16080.5 16106.1 16115.9 12053.6 12166.8 12166.8 12167.9 12174.0 20526.2 20749.7 20903.7 20925.4 21538.7 7913.3 8073.8 8142.4 8246.2 8260.6 915.0 928.7 1064.1 1065.1 1070.3 29495.0 29503.6 29629.0 29785.7 30036.2 871.4 980.4 1035.7 1073.8 1122.3 14085.6 14093.9 14172.8 14246.1 14375.4 324339.0 325726.0 329053.0 329844.0 330064.0 52243.2 53772.5 53802.0 53846.2 54099.5 1126.1 1226.2 1304.2 1350.1 1355.2 26455.6 27094.9 27187.3 27614.4 27808.7 39507.8 39758.6 39831.8 39841.6 39904.0 182725.0 184073.0 186301.0 186331.0 194648.4 28172.0 32066.8 32579.2 32879.8 33186.0 39767.0 42365.4 42728.8 42774.6 48661.0 37326.4 37448.6 37595.0 38459.0 39462.4 37809.7 38375.8 38576.0 38760.6 38775.6 36833.0 36991.1 37569.2 37585.2 37737.4 32061.5 33052.3 33283.5 33664.0 33879.0 25651.7 25864.6 25938.7 26443.5 26460.0 08:28:18 INFO - PROCESS | 1362 | 08:28:18 INFO - PROCESS | 1362 | [#2] jquery.html Cycles:180 Average:26304.16 Median:367.49 stddev:77316.33 (21038.9%) stddev-sans-first:77508.64 08:28:18 INFO - PROCESS | 1362 | Values: 341.6 357.9 364.4 370.6 370.9 16255.9 16874.6 17782.5 18195.3 18241.3 11292.8 11589.1 11608.9 11613.9 16668.4 5009.6 5046.6 5162.5 5181.5 5186.3 5120.0 5144.5 5163.6 5164.9 5165.3 5133.4 5135.5 5148.9 5156.5 5230.1 5158.6 5585.9 5601.1 5606.7 5623.4 5019.2 5033.5 5040.1 5044.2 5045.7 19858.7 20164.5 20580.3 20672.7 20751.8 1947.7 2047.2 2074.5 2209.2 2216.6 8961.2 10087.4 10773.9 11316.8 13592.3 1850.6 1864.5 1902.4 1957.4 1987.8 48906.0 57687.1 59497.0 59877.0 66410.3 9753.8 9947.0 10638.9 10664.7 10866.6 14098.6 14218.1 14225.1 14235.5 14249.2 7190.0 7733.7 7755.7 7819.1 7824.2 7368.0 7410.3 7513.2 7528.0 7542.8 4311.4 4404.6 4421.6 4469.3 4472.1 1782.9 1831.1 1848.9 1882.8 1908.7 874.6 884.9 914.6 983.4 1035.4 16658.8 16678.2 17186.6 17445.9 17906.0 918.3 934.4 960.2 966.6 996.7 9582.7 9754.7 9881.7 10241.3 10625.7 459149.0 472339.0 474719.0 476517.0 477740.0 75296.0 77765.6 78013.2 78166.0 78268.6 1035.6 1068.1 1081.2 1084.8 1090.8 14952.3 15133.5 15220.8 15293.2 15631.5 32892.3 33035.5 33074.5 34204.8 34368.5 45390.5 45713.3 51076.5 51165.0 51444.5 8407.2 8408.0 8419.7 8541.7 8678.0 8828.6 9723.1 10591.8 13018.7 13362.9 10746.8 11000.6 11137.7 11561.4 11573.9 10627.0 11153.7 11269.8 11341.9 11449.6 11137.9 11297.2 11504.7 11625.5 11699.9 8279.1 8281.8 8335.2 8451.3 8710.8 10737.2 11500.5 11592.3 11613.7 11830.8 08:28:18 INFO - PROCESS | 1362 | 08:28:18 INFO - PROCESS | 1362 | [#3] mootools.html Cycles:180 Average:5312.25 Median:6371.61 stddev:2721.23 (42.7%) stddev-sans-first:2712.68 08:28:18 INFO - PROCESS | 1362 | Values: 1363.7 1471.4 1475.7 1641.7 1801.3 7042.0 7160.3 7175.6 7176.2 7180.4 7441.9 7599.4 7615.7 7619.6 7620.3 1932.2 1983.3 2206.2 2285.0 2321.4 2241.5 2251.6 2255.6 2270.6 2273.0 2208.8 2235.3 2241.0 2278.1 2278.3 2217.3 2225.9 2226.6 2227.9 2230.2 2236.3 2239.1 2241.1 2256.1 2260.4 7644.8 7690.7 7696.5 7705.8 7712.3 4609.5 4720.5 4748.2 4752.7 4763.4 3114.5 3178.0 3279.8 3283.8 3313.5 1079.5 1092.9 1102.2 1124.8 1131.3 10609.8 10616.1 10627.6 10644.9 10646.9 4182.5 4253.3 4326.3 4331.5 4332.7 9039.4 9063.4 9068.8 9083.0 9119.8 4718.8 4729.1 4731.3 4732.3 4735.6 3740.7 3794.1 4207.8 4312.9 4315.4 3628.5 3658.8 3698.2 3706.1 3733.1 1175.8 1183.7 1191.3 1204.1 1223.3 1361.9 1380.5 1396.1 1401.3 1405.7 7114.6 7274.9 7287.2 7289.6 7305.6 476.8 490.2 491.5 495.7 496.7 5646.2 5674.5 5705.7 5714.7 5730.9 8420.8 8810.3 8826.2 8884.9 8952.3 8756.9 8779.2 8840.7 8841.3 8850.6 6934.7 6976.2 7026.7 7033.1 7052.9 6772.0 6795.3 6817.7 6830.6 6831.0 7772.1 7964.6 8029.8 8038.9 8069.4 8002.1 8197.3 8205.7 8289.4 8298.1 6589.2 6595.4 6640.5 6831.2 6835.5 7183.3 7196.4 7207.4 7217.6 7248.3 6582.7 6657.1 6695.1 6746.7 6828.7 6629.3 6678.7 6688.6 6722.7 6730.2 6775.8 6849.6 6881.8 6888.2 6890.3 6341.0 6406.5 6409.9 6410.9 6413.6 6402.2 6430.0 6467.7 6481.3 6490.8 08:28:18 INFO - PROCESS | 1362 | 08:28:18 INFO - PROCESS | 1362 | [#4] prototype.html Cycles:180 Average:5226.40 Median:5910.93 stddev:1569.21 (26.5%) stddev-sans-first:1530.04 08:28:18 INFO - PROCESS | 1362 | Values: 333.5 334.2 335.8 339.5 340.6 5849.7 5875.1 5902.2 5908.9 5913.0 5812.7 5871.1 5872.8 5874.3 5874.6 4365.5 4478.4 4507.1 4574.8 4596.6 4601.4 4606.0 4615.3 4617.6 4621.3 4565.5 4566.0 4566.9 4568.7 4579.8 4329.1 4425.0 4564.1 4571.3 4571.8 4026.7 4027.1 4029.9 4037.4 4039.8 5591.6 5609.2 5611.9 5615.3 5618.3 5307.4 5318.3 5323.3 5324.0 5326.1 6233.9 6252.8 6302.5 6305.7 6316.1 4169.9 4353.9 4372.0 4475.9 4488.9 6450.3 6494.2 6514.4 6520.9 6533.8 4438.5 4442.4 4443.5 4443.7 4447.0 4486.5 4487.4 4488.5 4490.8 4492.4 5198.0 5205.2 5206.7 5208.0 5219.5 6047.8 6271.7 6284.6 6288.5 6295.9 1540.3 1564.5 1578.8 1579.1 1582.2 972.8 1003.3 1032.2 1041.7 1067.4 5901.5 5904.3 5914.4 5915.7 5920.9 6391.6 6405.7 6410.9 6411.5 6411.6 5957.0 5968.8 5974.3 5980.8 5987.2 3386.6 3416.9 3422.7 3425.6 3426.9 6605.1 6746.3 6758.6 6763.5 6774.7 6501.5 6521.1 6526.4 6527.2 6536.9 6748.6 6753.9 6762.8 6838.5 6839.8 6389.0 6394.7 6397.0 6398.6 6401.4 6175.0 6332.8 6336.8 6346.3 6346.6 6722.3 6740.6 6755.7 6757.3 6759.9 4442.7 4447.5 4448.8 4449.5 4451.6 6373.5 6374.6 6381.4 6383.7 6384.6 6195.6 6195.8 6196.3 6204.1 6215.6 6052.4 6214.6 6216.4 6225.7 6227.0 6077.6 6098.0 6099.4 6103.5 6117.6 6237.1 6237.3 6240.5 6240.9 6247.1 5908.6 6008.8 6090.6 6098.1 6101.7 08:28:18 INFO - PROCESS | 1362 | 08:28:18 INFO - PROCESS | 1362 | [#5] yui.html Cycles:180 Average:14090.53 Median:47543.41 stddev:16594.58 (34.9%) stddev-sans-first:16610.77 08:28:18 INFO - PROCESS | 1362 | Values: 722.5 724.1 756.8 825.0 842.2 12845.1 12954.2 12998.2 13003.1 13019.7 12852.4 13239.3 13258.7 13264.0 13435.4 820.6 827.5 832.2 834.2 835.4 819.7 827.5 827.7 828.8 829.6 868.7 868.8 869.5 871.9 874.2 867.3 868.0 870.0 870.3 871.1 640.1 640.5 640.6 643.7 645.6 11938.2 12032.9 12039.7 12082.1 12109.2 11527.2 11535.6 11654.2 11658.0 11671.2 9376.2 9635.9 9876.4 11816.9 12117.1 4312.1 4328.4 4389.2 4474.4 4523.9 48543.8 50409.2 50863.0 50901.5 50959.0 9412.8 9415.8 9598.9 9768.8 10042.8 17799.6 17847.3 17882.8 17904.4 17941.6 7560.5 7607.4 7721.7 7726.4 8047.4 4562.7 4641.5 4661.9 4738.0 4928.4 3087.1 3106.4 3118.3 3127.9 3141.3 592.2 595.9 597.6 603.8 605.8 486.3 618.6 636.7 638.6 662.8 8700.5 8821.9 8847.7 8896.9 8902.1 625.7 631.7 635.4 665.7 674.3 4025.1 4053.0 4140.8 4186.7 4265.9 61477.3 63767.0 64648.4 64748.0 64764.7 48460.5 48504.3 49801.8 54268.5 54457.0 45178.3 47516.5 47570.3 48149.3 48354.0 8697.9 8742.9 8832.2 9038.8 9055.4 34666.0 34782.3 35026.3 35028.1 36083.6 41741.0 42384.8 42766.6 47127.3 47144.5 11184.7 11200.3 11395.8 11665.9 11762.8 12136.9 12357.0 12364.7 12851.2 12875.5 11132.6 11226.7 11655.0 11671.8 11691.0 10814.2 10839.7 11109.8 11761.1 11842.6 11486.3 11763.7 11789.4 11877.5 12099.3 10086.2 10410.9 10497.9 10587.2 10723.0 9480.4 9675.4 9832.4 10114.9 10335.3 08:28:18 INFO - PROCESS | 1362 | -------- Summary: end -------- 08:28:18 INFO - PROCESS | 1362 | 08:28:18 INFO - TEST-INFO | 1362: exit 0 08:28:18 INFO - TEST-OK | dromaeo_css | took 1113206ms 08:28:18 INFO - TEST-START | kraken 08:28:18 INFO - operating with platform_type : linux_ 08:28:18 INFO - Initialising browser for kraken test... 08:28:19 INFO - TEST-INFO | started process 1541 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvSebuv/profile http://localhost:33603/getInfo.html) 08:28:23 INFO - PROCESS | 1541 | __metrics Screen width/height:1600/1200 08:28:23 INFO - PROCESS | 1541 | colorDepth:24 08:28:23 INFO - PROCESS | 1541 | Browser inner width/height: 1024/697 08:28:23 INFO - PROCESS | 1541 | __metrics 08:28:23 ERROR - PROCESS | 1541 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:28:23 INFO - PROCESS | 1541 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 08:28:24 INFO - TEST-INFO | 1541: exit 0 08:28:24 INFO - Browser initialized. 08:28:24 INFO - Running cycle 1/1 for kraken test... 08:28:24 INFO - TEST-INFO | started process 1622 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvSebuv/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:28:36 INFO - PROCESS | 1622 | RSS: Main: 155160576 08:28:36 INFO - PROCESS | 1622 | 08:28:39 INFO - PROCESS | 1622 | Cycle 1(1): loaded http://localhost:33603/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33603/tests/kraken/driver.html?testName=audio-beat-detection) 08:28:39 INFO - PROCESS | 1622 | RSS: Main: 194879488 08:28:39 INFO - PROCESS | 1622 | 08:28:42 INFO - PROCESS | 1622 | Cycle 1(1): loaded http://localhost:33603/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33603/tests/kraken/driver.html?testName=audio-dft) 08:28:42 INFO - PROCESS | 1622 | RSS: Main: 184246272 08:28:42 INFO - PROCESS | 1622 | 08:28:45 INFO - PROCESS | 1622 | Cycle 1(1): loaded http://localhost:33603/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33603/tests/kraken/driver.html?testName=audio-fft) 08:28:46 INFO - PROCESS | 1622 | RSS: Main: 171061248 08:28:46 INFO - PROCESS | 1622 | 08:28:48 INFO - PROCESS | 1622 | Cycle 1(1): loaded http://localhost:33603/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33603/tests/kraken/driver.html?testName=audio-oscillator) 08:28:48 INFO - PROCESS | 1622 | RSS: Main: 174505984 08:28:48 INFO - PROCESS | 1622 | 08:28:51 INFO - PROCESS | 1622 | Cycle 1(1): loaded http://localhost:33603/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33603/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:28:51 INFO - PROCESS | 1622 | RSS: Main: 174428160 08:28:51 INFO - PROCESS | 1622 | 08:28:54 INFO - PROCESS | 1622 | Cycle 1(1): loaded http://localhost:33603/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33603/tests/kraken/driver.html?testName=imaging-darkroom) 08:28:55 INFO - PROCESS | 1622 | RSS: Main: 174690304 08:28:55 INFO - PROCESS | 1622 | 08:28:58 INFO - PROCESS | 1622 | Cycle 1(1): loaded http://localhost:33603/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33603/tests/kraken/driver.html?testName=imaging-desaturate) 08:28:59 INFO - PROCESS | 1622 | RSS: Main: 176238592 08:28:59 INFO - PROCESS | 1622 | 08:29:02 INFO - PROCESS | 1622 | Cycle 1(1): loaded http://localhost:33603/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33603/tests/kraken/driver.html?testName=json-parse-financial) 08:29:02 INFO - PROCESS | 1622 | RSS: Main: 174899200 08:29:02 INFO - PROCESS | 1622 | 08:29:04 INFO - PROCESS | 1622 | Cycle 1(1): loaded http://localhost:33603/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33603/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:29:04 INFO - PROCESS | 1622 | RSS: Main: 184311808 08:29:04 INFO - PROCESS | 1622 | 08:29:06 INFO - PROCESS | 1622 | Cycle 1(1): loaded http://localhost:33603/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33603/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:29:07 INFO - PROCESS | 1622 | RSS: Main: 182984704 08:29:07 INFO - PROCESS | 1622 | 08:29:09 INFO - PROCESS | 1622 | Cycle 1(1): loaded http://localhost:33603/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33603/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:29:09 INFO - PROCESS | 1622 | RSS: Main: 194547712 08:29:09 INFO - PROCESS | 1622 | 08:29:12 INFO - PROCESS | 1622 | Cycle 1(1): loaded http://localhost:33603/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33603/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:29:12 INFO - PROCESS | 1622 | RSS: Main: 201428992 08:29:12 INFO - PROCESS | 1622 | 08:29:15 INFO - PROCESS | 1622 | Cycle 1(1): loaded http://localhost:33603/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33603/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:29:16 INFO - PROCESS | 1622 | RSS: Main: 200826880 08:29:16 INFO - PROCESS | 1622 | 08:29:17 INFO - PROCESS | 1622 | Cycle 1(1): loaded http://localhost:33603/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33603/tests/kraken/driver.html?testName=ai-astar) 08:29:17 INFO - PROCESS | 1622 | RSS: Main: 261206016 08:29:17 INFO - PROCESS | 1622 | 08:29:17 INFO - PROCESS | 1622 | __start_tp_report 08:29:17 INFO - PROCESS | 1622 | _x_x_mozilla_page_load 08:29:17 INFO - PROCESS | 1622 | _x_x_mozilla_page_load_details 08:29:17 INFO - PROCESS | 1622 | |i|pagename|runs| 08:29:17 INFO - PROCESS | 1622 | |0;ai-astar;111;111;108;111;111;110;98;109;110;109 08:29:17 INFO - PROCESS | 1622 | |1;audio-beat-detection;156;129;150;167;128;152;149;128;168;127 08:29:17 INFO - PROCESS | 1622 | |2;audio-dft;160;162;159;160;159;159;159;165;161;160 08:29:17 INFO - PROCESS | 1622 | |3;audio-fft;73;76;99;102;75;75;75;121;96;75 08:29:17 INFO - PROCESS | 1622 | |4;audio-oscillator;94;94;149;93;93;93;139;94;93;139 08:29:17 INFO - PROCESS | 1622 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;117;117;117 08:29:17 INFO - PROCESS | 1622 | |6;imaging-darkroom;145;145;145;145;145;144;145;145;145;146 08:29:17 INFO - PROCESS | 1622 | |7;imaging-desaturate;95;95;95;95;95;95;96;95;95;95 08:29:17 INFO - PROCESS | 1622 | |8;json-parse-financial;60;57;57;58;56;59;58;67;57;55 08:29:17 INFO - PROCESS | 1622 | |9;json-stringify-tinderbox;69;69;68;68;69;68;69;69;69;68 08:29:17 INFO - PROCESS | 1622 | |10;stanford-crypto-aes;91;82;82;82;83;80;81;81;81;82 08:29:17 INFO - PROCESS | 1622 | |11;stanford-crypto-ccm;117;130;115;113;123;114;113;116;118;113 08:29:17 INFO - PROCESS | 1622 | |12;stanford-crypto-pbkdf2;152;133;130;140;142;131;140;140;146;141 08:29:17 INFO - PROCESS | 1622 | |13;stanford-crypto-sha256-iterative;66;67;70;68;67;68;67;68;68;65 08:29:17 INFO - PROCESS | 1622 | __end_tp_report 08:29:17 INFO - PROCESS | 1622 | __start_cc_report 08:29:17 INFO - PROCESS | 1622 | _x_x_mozilla_cycle_collect,1028 08:29:17 INFO - PROCESS | 1622 | __end_cc_report 08:29:17 INFO - PROCESS | 1622 | __startTimestamp1457713757951__endTimestamp 08:29:17 INFO - PROCESS | 1622 | 08:29:17 INFO - PROCESS | 1622 | ------- Summary: start ------- 08:29:17 INFO - PROCESS | 1622 | Number of tests: 14 08:29:17 INFO - PROCESS | 1622 | 08:29:17 INFO - PROCESS | 1622 | [#0] ai-astar Cycles:10 Average:108.80 Median:111.00 stddev:3.94 (3.5%) stddev-sans-first:4.10 08:29:17 INFO - PROCESS | 1622 | Values: 111.0 111.0 108.0 111.0 111.0 110.0 98.0 109.0 110.0 109.0 08:29:17 INFO - PROCESS | 1622 | 08:29:17 INFO - PROCESS | 1622 | [#1] audio-beat-detection Cycles:10 Average:145.40 Median:151.00 stddev:16.26 (10.8%) stddev-sans-first:16.79 08:29:17 INFO - PROCESS | 1622 | Values: 156.0 129.0 150.0 167.0 128.0 152.0 149.0 128.0 168.0 127.0 08:29:17 INFO - PROCESS | 1622 | 08:29:17 INFO - PROCESS | 1622 | [#2] audio-dft Cycles:10 Average:160.40 Median:160.00 stddev:1.90 (1.2%) stddev-sans-first:2.01 08:29:17 INFO - PROCESS | 1622 | Values: 160.0 162.0 159.0 160.0 159.0 159.0 159.0 165.0 161.0 160.0 08:29:17 INFO - PROCESS | 1622 | 08:29:17 INFO - PROCESS | 1622 | [#3] audio-fft Cycles:10 Average:86.70 Median:75.00 stddev:16.66 (22.2%) stddev-sans-first:16.92 08:29:17 INFO - PROCESS | 1622 | Values: 73.0 76.0 99.0 102.0 75.0 75.0 75.0 121.0 96.0 75.0 08:29:17 INFO - PROCESS | 1622 | 08:29:17 INFO - PROCESS | 1622 | [#4] audio-oscillator Cycles:10 Average:108.10 Median:93.00 stddev:23.78 (25.6%) stddev-sans-first:24.67 08:29:17 INFO - PROCESS | 1622 | Values: 94.0 94.0 149.0 93.0 93.0 93.0 139.0 94.0 93.0 139.0 08:29:17 INFO - PROCESS | 1622 | 08:29:17 INFO - PROCESS | 1622 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 08:29:17 INFO - PROCESS | 1622 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 08:29:17 INFO - PROCESS | 1622 | 08:29:17 INFO - PROCESS | 1622 | [#6] imaging-darkroom Cycles:10 Average:145.00 Median:145.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 08:29:17 INFO - PROCESS | 1622 | Values: 145.0 145.0 145.0 145.0 145.0 144.0 145.0 145.0 145.0 146.0 08:29:17 INFO - PROCESS | 1622 | 08:29:17 INFO - PROCESS | 1622 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 08:29:17 INFO - PROCESS | 1622 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 08:29:17 INFO - PROCESS | 1622 | 08:29:17 INFO - PROCESS | 1622 | [#8] json-parse-financial Cycles:10 Average:58.40 Median:58.00 stddev:3.34 (5.8%) stddev-sans-first:3.49 08:29:17 INFO - PROCESS | 1622 | Values: 60.0 57.0 57.0 58.0 56.0 59.0 58.0 67.0 57.0 55.0 08:29:17 INFO - PROCESS | 1622 | 08:29:17 INFO - PROCESS | 1622 | [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:69.00 stddev:0.52 (0.7%) stddev-sans-first:0.53 08:29:17 INFO - PROCESS | 1622 | Values: 69.0 69.0 68.0 68.0 69.0 68.0 69.0 69.0 69.0 68.0 08:29:17 INFO - PROCESS | 1622 | 08:29:17 INFO - PROCESS | 1622 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:82.00 stddev:3.10 (3.8%) stddev-sans-first:0.88 08:29:17 INFO - PROCESS | 1622 | Values: 91.0 82.0 82.0 82.0 83.0 80.0 81.0 81.0 81.0 82.0 08:29:17 INFO - PROCESS | 1622 | 08:29:17 INFO - PROCESS | 1622 | [#11] stanford-crypto-ccm Cycles:10 Average:117.20 Median:116.50 stddev:5.45 (4.7%) stddev-sans-first:5.78 08:29:17 INFO - PROCESS | 1622 | Values: 117.0 130.0 115.0 113.0 123.0 114.0 113.0 116.0 118.0 113.0 08:29:17 INFO - PROCESS | 1622 | 08:29:17 INFO - PROCESS | 1622 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.50 Median:140.50 stddev:6.77 (4.8%) stddev-sans-first:5.46 08:29:17 INFO - PROCESS | 1622 | Values: 152.0 133.0 130.0 140.0 142.0 131.0 140.0 140.0 146.0 141.0 08:29:17 INFO - PROCESS | 1622 | 08:29:17 INFO - PROCESS | 1622 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:68.00 stddev:1.35 (2.0%) stddev-sans-first:1.33 08:29:17 INFO - PROCESS | 1622 | Values: 66.0 67.0 70.0 68.0 67.0 68.0 67.0 68.0 68.0 65.0 08:29:17 INFO - PROCESS | 1622 | -------- Summary: end -------- 08:29:17 INFO - PROCESS | 1622 | 08:29:18 INFO - TEST-INFO | 1622: exit 0 08:29:18 INFO - TEST-OK | kraken | took 59914ms 08:29:18 INFO - SUITE-END | took 1173s 08:29:19 INFO - Completed test suite (00:19:33) 08:29:19 INFO - javascript benchmark 08:29:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3128.171034675811, 3192.2817366092618, 3222.4038552867723, 3223.016979821155, 3256.5603643508125, 4986.252062190673, 5122.513361230686, 5137.871553211172, 5143.408508021574, 5198.142306519425, 5078.949210507893, 5155.355580552431, 5158.071547121526, 5198.350206224222, 5219.973900130494, 4564.7945842437, 4638.652101092414, 4668.6731928765, 4675.4155730533685, 4749.026449577846, 4688.671792974493, 4704.341392205094, 4732.1482133216, 4753.595944344735, 4790.353302304179, 4573.245414506602, 4668.533146685339, 4679.415073115861, 4720.527947205286, 4753.71477711335, 4692.95307046932, 4703.2709929960565, 4705.976470117662, 4733.881652958704, 4737.786799593992, 4609.700369476007, 4693.272542755878, 4702.976485117552, 4733.644976626767, 4756.334113224151, 4805.231163013901, 4859.392575928009, 4859.927101093486, 4875.414950205998, 4909.7790599423115, 5457.727113644302, 5470.91793623096, 5471.863203419906, 5474.2609747683955, 5527.309086364205, 5379.677219366811, 5467.234587157761, 5495.477929596722, 5525.364583072957, 5544.390117087158, 5196.0647083524955, 5198.194279886624, 5216.347956505437, 5231.110711179109, 5262.657927234717, 5666.688332141772, 5670.8015219467125, 5679.148127780783, 5679.290088738908, 5694.886102277931, 5257.684538927677, 5407.297051383295, 5415.5938304626525, 5432.864178395572, 5453.345598528202, 5532.059549876451, 5551.7779288828, 5554.361248456479, 5557.3886872444, 5567.972160139255, 5522.30971128609, 5529.115341545414, 5541.556675465953, 5543.196236545678, 5546.223528705985, 5250.501202385767, 5512.80705175317, 5557.277553917965, 5587.27365442498, 5610.663360198401, 4227.894302642397, 4228.703990720682, 4229.0, 4237.809298581509, 4270.0605866709275, 3835.6547910687614, 3847.03824043989, 3853.7302388833073, 3856.7107466940092, 3866.516685414323, 5004.424491183488, 5095.77069031887, 5218.843434696965, 5240.947590524046, 5245.895082098413, 5464.836054918279, 5477.507024367826, 5481.698506582176, 5489.917651235235, 5495.945040549544, 5154.819581314636, 5175.094358487249, 5183.792648294101, 5185.403678576937, 5189.117849965515, 4510.954890451119, 4653.906921861544, 4727.64542659302, 4744.715317080986, 4749.168895443284, 5692.14617807324, 5697.173909783141, 5708.372079071299, 5710.057840456361, 5714.885702286014, 5334.333208348957, 5406.216098665593, 5414.0796064669885, 5414.3232095988005, 5458.727063646881, 5786.450287222707, 5849.8537536560225, 5857.58996870232, 5883.264591926009, 5886.323072846506, 5383.569314454756, 5387.676739395492, 5388.057090009311, 5389.056915039774, 5392.676439413648, 5337.172738225581, 5436.891262174813, 5445.945540544544, 5449.509544141047, 5496.120620700669, 5384.515393614593, 5424.837254882202, 5425.21334406501, 5469.288992430958, 5474.753636086306, 5351.625386223082, 5386.865328366822, 5389.62272640927, 5398.7300634967305, 5407.594430417813, 5106.336176297206, 5193.68837869729, 5270.973645131749, 5279.894402112013, 5357.785688572413, 5284.180951952453, 5335.813246536352, 5354.866128346823, 5381.354237491526, 5397.190421436659, 5231.607629427732, 5240.947590524046, 5241.187615919539, 5243.711595862264, 5244.187150991603], "unit": "score", "name": "dojo.html", "value": 5078.449734633317}, {"lowerIsBetter": false, "replicates": [506.7289000384795, 532.3771187710379, 544.0723566319423, 558.9659130608375, 592.4312659846547, 28728.71271287289, 36941.81529092354, 37037.81481092598, 37097.25805483895, 37147.0, 40525.39211911824, 41111.17777644453, 41116.38325425121, 41159.58840411595, 41222.7938860306, 7450.813729656775, 7640.656170472342, 7642.121156067068, 8453.619587118594, 8692.739217823475, 10246.0, 10448.477576121164, 10505.107065899409, 10510.474476276193, 10520.947395263012, 10232.386056836576, 10339.483025848715, 10349.896501035006, 10353.482325883713, 10354.896451035469, 10056.89943100567, 10161.187105031617, 10161.59353625854, 10171.64399246023, 10175.0, 10023.849642255373, 10140.746481337952, 10152.847707284396, 10159.390436573829, 10166.542505587193, 41450.37824432636, 41488.792556037326, 41691.7915410424, 41799.16401671949, 41896.58103418957, 3347.548081009081, 3358.4458564336855, 3515.209077957439, 3565.447355659877, 3808.390657494815, 31648.208794780083, 31869.813018698176, 31873.203169920707, 32149.0, 33180.668193318, 4004.6395824375945, 4043.858464953742, 4062.2484840304637, 4067.3085575452246, 4114.876553703393, 282311.0, 283230.0, 283886.99999999796, 283917.0, 284983.0, 60861.0, 61083.0, 61443.38556614466, 61482.385176148564, 61528.38471615316, 67877.0, 69417.65291173512, 69461.0, 69511.65244173747, 69587.0, 15864.841351586567, 16016.199190040452, 16080.517584472485, 16106.114163720873, 16115.919420402823, 12053.63839084829, 12166.756664866652, 12166.81749773754, 12167.878321216851, 12174.0, 20526.17895284202, 20749.68875466839, 20903.68644470334, 20925.37223883286, 21538.676919846213, 7913.287804097658, 8073.7577872663915, 8142.4300298978505, 8246.175382461706, 8260.628271727786, 914.9954250228707, 928.6935311347239, 1064.1274155192668, 1065.0840277361463, 1070.2936062198912, 29495.0, 29503.55744663832, 29628.965139168962, 29785.702142978727, 30036.249093772392, 871.4379225399582, 980.3823591137681, 1035.699647102332, 1073.8013467508536, 1122.259308856151, 14085.577432677037, 14093.85906140946, 14172.787408188886, 14246.07400518963, 14375.424983000772, 324339.0, 325726.0, 329053.0, 329844.0, 330064.0, 52243.21635175475, 53772.462275377526, 53802.0, 53846.19230711542, 54099.45900541023, 1126.14975693351, 1226.178460431513, 1304.243538747524, 1350.0549615269351, 1355.1665725578698, 26455.60316595214, 27094.864525677247, 27187.32031699144, 27614.44771104607, 27808.721912780613, 39507.802460987514, 39758.60241397549, 39831.80084099561, 39841.60158398495, 39904.0, 182725.0, 184073.0, 186301.0, 186331.0, 194648.37461377567, 28172.0, 32066.839665801523, 32579.18552036218, 32879.8356008228, 33186.0, 39767.0, 42365.36451953161, 42728.78635606802, 42774.572254278304, 48661.0, 37326.44010339793, 37448.62551374451, 37595.0, 38459.0, 39462.40806387849, 37809.68552334965, 38375.80812095922, 38576.0, 38760.61239387683, 38775.61224387833, 36833.0, 36991.07522311964, 37569.2486150281, 37585.2482950334, 37737.433938490394, 32061.51907721433, 33052.33895322032, 33283.50074748929, 33664.0, 33879.0, 25651.743482565682, 25864.612030819175, 25938.740612593632, 26443.471130576894, 26460.0], "unit": "score", "name": "ext.html", "value": 18757.16859950947}, {"lowerIsBetter": false, "replicates": [341.5696222759323, 357.91767893384537, 364.3769154745385, 370.6090074970905, 370.86463440844085, 16255.943363681366, 16874.578135546617, 17782.466526004224, 18195.272189112453, 18241.270349186016, 11292.830607540873, 11589.130815188852, 11608.883911160885, 11613.941930290357, 16668.416605418814, 5009.599232061444, 5046.646734728571, 5162.483751624826, 5181.481851814826, 5186.273921650972, 5120.0, 5144.4598317176715, 5163.561097306733, 5164.92252616211, 5165.3026841376495, 5133.383993920716, 5135.460776618457, 5148.871278218037, 5156.53591176794, 5230.137027390476, 5158.638895277332, 5585.916211256835, 5601.103823388259, 5606.747696353674, 5623.409541998072, 5019.171836646949, 5033.546980771712, 5040.143175660147, 5044.218146187347, 5045.722485263309, 19858.70211946822, 20164.495887602927, 20580.27969021077, 20672.689909651366, 20751.792482075136, 1947.6883698608156, 2047.1624773257392, 2074.481379655086, 2209.215728416405, 2216.601011817872, 8961.238294744955, 10087.445190514518, 10773.946130269298, 11316.830247546211, 13592.25242611656, 1850.5558665920216, 1864.5152260412256, 1902.4197619725978, 1957.412776167144, 1987.8409727221933, 48906.0, 57687.13469297922, 59497.0, 59877.0, 66410.3358966409, 9753.756156096155, 9946.950265248628, 10638.893611063944, 10664.733381665521, 10866.61966831157, 14098.577042688736, 14218.075825071544, 14225.075370101118, 14235.501757438647, 14249.216293103771, 7189.96405017982, 7733.651985660659, 7755.72854950074, 7819.0617125945255, 7824.178461261599, 7368.042154519878, 7410.296021877913, 7513.248675132443, 7528.0, 7542.811429714301, 4311.439512863308, 4404.61254704767, 4421.557844215553, 4469.262571675637, 4472.060867217856, 1782.857371410284, 1831.111910723298, 1848.8613353998503, 1882.7552418185821, 1908.7327774111636, 874.6151693254948, 884.893812742475, 914.6432891172448, 983.4197823284154, 1035.420164707751, 16658.750118748227, 16678.249478773483, 17186.570335741708, 17445.912770436065, 17906.0, 918.3342076994126, 934.4393363981693, 960.159860122393, 966.5988614724811, 996.6960077176531, 9582.712518624452, 9754.658586949423, 9881.654142104991, 10241.334313269763, 10625.734356641145, 459149.0, 472339.0, 474719.0, 476517.0, 477740.0, 75296.0, 77765.61117194378, 78013.2198678006, 78166.0, 78268.60865695635, 1035.6064695415694, 1068.124138206663, 1081.2485322700804, 1084.793889161041, 1090.8091084060259, 14952.252387380806, 15133.470328538448, 15220.847791521943, 15293.158876261912, 15631.452899148475, 32892.34215315728, 33035.504467432525, 33074.503882442266, 34204.82897585496, 34368.48447273243, 45390.54609453863, 45713.31430028619, 51076.48923510866, 51165.0, 51444.48555514397, 8407.201315874981, 8408.0, 8419.747407577783, 8541.676040213777, 8678.0, 8828.558572071242, 9723.076307750753, 10591.788164236517, 13018.739625207632, 13362.866371336162, 10746.785064298827, 11000.559977600806, 11137.665870023913, 11561.42192890369, 11573.88426115728, 10627.0, 11153.665390038312, 11269.830952535554, 11341.943290283496, 11449.59926402572, 11137.944310278397, 11297.209195356574, 11504.654860354203, 11625.534978600761, 11699.88300116988, 8279.10881885513, 8281.792955176168, 8335.249827515552, 8451.323894088335, 8710.782230444289, 10737.194710396596, 11500.539978401104, 11592.304461732323, 11613.6515904523, 11830.763384732085], "unit": "score", "name": "jquery.html", "value": 8431.038750938298}, {"lowerIsBetter": false, "replicates": [1363.747706674266, 1471.389373410035, 1475.7343678137934, 1641.679872424877, 1801.2524802207076, 7042.0, 7160.28397160285, 7175.60534170621, 7176.246494118121, 7180.389666878308, 7441.888371674429, 7599.392048636109, 7615.657295421705, 7619.619019049053, 7620.276073772997, 1932.2271091563416, 1983.2959299448705, 2206.2278202629113, 2284.999999999996, 2321.431249343913, 2241.529278851443, 2251.6284813005836, 2255.6278214094655, 2270.6139956207485, 2273.022600281878, 2208.7791220877866, 2235.307054813013, 2240.9551808963893, 2278.0773786616364, 2278.305116939333, 2217.2904670505445, 2225.9109635614554, 2226.6103431899514, 2227.94430139247, 2230.152542034025, 2236.3067449090836, 2239.1267405711787, 2241.081156725751, 2256.0975609756065, 2260.42359198405, 7644.770656880302, 7690.730824421118, 7696.538207707499, 7705.807354816175, 7712.305892469704, 4609.469910960215, 4720.480747117815, 4748.169070412699, 4752.6910750801435, 4763.428388593391, 3114.5016797312323, 3178.0, 3279.770416070876, 3283.7865538739907, 3313.4698448248164, 1079.4602698650674, 1092.9071028962549, 1102.1568500097433, 1124.831275308702, 1131.264677959333, 10609.787804243872, 10616.097631701316, 10627.628033018884, 10644.946775266151, 10646.946765266124, 4182.456280683492, 4253.3194688849635, 4326.264535029052, 4331.523532411432, 4332.696711230246, 9039.367244292967, 9063.365564410427, 9068.773280667903, 9082.954585227164, 9119.81760364789, 4718.811247550128, 4729.07782982322, 4731.266653668687, 4732.313814496879, 4735.550122738403, 3740.7007439404783, 3794.051487128218, 4207.768572728468, 4312.870613881589, 4315.374270730789, 3628.4738712886483, 3658.762180458262, 3698.223373091681, 3706.1475860552223, 3733.104055026774, 1175.841261429713, 1183.7024742462793, 1191.3149938785234, 1204.1209916760813, 1223.2782658231686, 1361.9387127579282, 1380.496118916588, 1396.0855639556107, 1401.2643362234908, 1405.6766943602825, 7114.64426778659, 7274.927250727531, 7287.161976372785, 7289.599072051088, 7305.561666300039, 476.797361121522, 490.2132078014806, 491.52322247419943, 495.6951474842946, 496.72431800351154, 5646.20953066571, 5674.460926212003, 5705.657660540381, 5714.657120572696, 5730.914036289459, 8420.789480263042, 8810.295176385875, 8826.249768769727, 8884.911150888538, 8952.283817294601, 8756.912430875736, 8779.165979231962, 8840.690575829944, 8841.292696584258, 8850.557472126367, 6934.653267336613, 6976.232614412411, 7026.683799229047, 7033.050538177281, 7052.858942821217, 6771.966140169267, 6795.3204679531655, 6817.693203805741, 6830.59016459014, 6830.965845170742, 7772.1450640428375, 7964.6415911282975, 8029.799255018671, 8038.87941680887, 8069.394795390252, 8002.119766825528, 8197.262246397853, 8205.712800052208, 8289.378296627898, 8298.128696487023, 6589.24223714279, 6595.406413422815, 6640.468762498892, 6831.248562658005, 6835.453163746789, 7183.317584829433, 7196.352328290479, 7207.387372073433, 7217.6030318330895, 7248.311410416002, 6582.670866456562, 6657.101291325803, 6695.096162018065, 6746.696398661974, 6828.7268509259075, 6629.270780214076, 6678.7328506859185, 6688.632125233159, 6722.731090756511, 6730.192376914802, 6775.830604234933, 6849.554778939353, 6881.759138430131, 6888.173419189528, 6890.31096890307, 6341.048842673636, 6406.455451286693, 6409.935900640934, 6410.935890641033, 6413.647249401328, 6402.167718196604, 6430.0, 6467.708953097028, 6481.319461456479, 6490.837729056811], "unit": "score", "name": "mootools.html", "value": 4337.220109269116}, {"lowerIsBetter": false, "replicates": [333.5080755885068, 334.2462746506627, 335.7800640580418, 339.5365326329561, 340.57938446019165, 5849.707514624262, 5875.059990401536, 5902.232709747732, 5908.881822363555, 5912.9704351478185, 5812.738426770795, 5871.119332100187, 5872.7944521941745, 5874.3244526879425, 5874.5594080443925, 4365.519792822787, 4478.395416618748, 4507.076049409863, 4574.83988060418, 4596.6322694184555, 4601.401817763686, 4606.009707912798, 4615.3077038444335, 4617.584417402433, 4621.329907163459, 4565.520620334867, 4565.954340456603, 4566.862994110165, 4568.680192386534, 4579.816807327703, 4329.112531930947, 4424.9557504424865, 4564.109998550284, 4571.314302854598, 4571.817127314904, 4026.6577340925764, 4027.1140349123148, 4029.8992525186814, 4037.414574886625, 4039.7576145431367, 5591.580631452657, 5609.186667933127, 5611.887762244733, 5615.2700148980775, 5618.269624948772, 5307.416184219733, 5318.282031925679, 5323.307969963918, 5324.0, 5326.067938110854, 6233.906491402633, 6252.812415627538, 6302.4958003359625, 6305.747770089191, 6316.08416779569, 4169.854055108087, 4353.869383918487, 4371.956280437187, 4475.910481790346, 4488.910221795579, 6450.290468048511, 6494.155759751202, 6514.44627206688, 6520.869582608321, 6533.836654083639, 4438.467383913951, 4442.355858400514, 4443.533428989909, 4443.666724995638, 4447.0, 4486.506484286726, 4487.371767952489, 4488.506264310923, 4490.820367185276, 4492.3710680504755, 5198.0, 5205.24523944026, 5206.713630750345, 5208.0, 5219.530242278213, 6047.78832740852, 6271.749130034747, 6284.622922624566, 6288.5283603728985, 6295.937040629627, 1540.3299564689396, 1564.4837203722743, 1578.8263291037977, 1579.0920220873045, 1582.2405245482232, 972.7908499672604, 1003.3428104591504, 1032.1897310611134, 1041.656253436364, 1067.3969207397795, 5901.468867801833, 5904.261967254093, 5914.408559144051, 5915.733791979371, 5920.881582368328, 6391.552591318656, 6405.743770249231, 6410.8717825643225, 6411.519136064814, 6411.6153030818305, 5956.970215148896, 5968.820935371946, 5974.3428222895445, 5980.760769569169, 5987.161797348374, 3386.559747232844, 3416.8804091857164, 3422.6748458896363, 3425.6403077676982, 3426.931461370759, 6605.07528945948, 6746.257911629717, 6758.628275444898, 6763.5265531413315, 6774.695138718671, 6501.47988160946, 6521.108878425299, 6526.379993900572, 6527.15147030883, 6536.901946470807, 6748.628825414551, 6753.898691519631, 6762.797116086525, 6838.521303508806, 6839.760608378683, 6388.968055159695, 6394.680265986589, 6397.040443933447, 6398.648074355769, 6401.3598640135615, 6174.969125154345, 6332.778352757631, 6336.809895703136, 6346.270178929482, 6346.619202847844, 6722.2605513394465, 6740.561863478858, 6755.6622168892345, 6757.290484499057, 6759.898601520883, 4442.6890117691455, 4447.488538817948, 4448.799804008762, 4449.488308844395, 4451.554844515523, 6373.521985850987, 6374.617522948638, 6381.425671689571, 6383.712732926937, 6384.553081284451, 6195.628262304276, 6195.783147589813, 6196.318404975359, 6204.13142160089, 6215.564910456224, 6052.425019623129, 6214.627122372672, 6216.44052035319, 6225.719842607003, 6227.0, 6077.604955677867, 6097.993831017832, 6099.390060994043, 6103.511719062376, 6117.632942023492, 6237.126802247598, 6237.282712488122, 6240.53196010292, 6240.937590624036, 6247.09417134522, 5908.556858235564, 6008.789692360747, 6090.573659843945, 6098.146259523582, 6101.6644084574], "unit": "score", "name": "prototype.html", "value": 4713.898521050198}, {"lowerIsBetter": false, "replicates": [722.5014739829518, 724.1455083002057, 756.795665170404, 824.9793755156124, 842.2209456252968, 12845.100842940998, 12954.222746635209, 12998.15511991721, 13003.089783715144, 13019.739605207902, 12852.421641026152, 13239.271840048817, 13258.668533286673, 13264.0, 13435.395407206675, 820.5979070255577, 827.5365795154703, 832.1719888710742, 834.1616675241374, 835.419383528448, 819.700809204639, 827.4745536584282, 827.6896163938524, 828.7638023163399, 829.5686243153557, 868.7046404222563, 868.8175483148547, 869.4739682492096, 871.9346049046347, 874.1608056265992, 867.3451544084239, 868.0364795077459, 869.9864657673802, 870.3124531620012, 871.1071152069117, 640.1198352265635, 640.5196102922808, 640.5900223856736, 643.7296335539085, 645.5674697952384, 11938.22401543897, 12032.879671203264, 12039.699007524794, 12082.093842961813, 12109.212901161485, 11527.19309648325, 11535.59625413115, 11654.242474239232, 11658.0, 11671.1830171888, 9376.203022743006, 9635.90364096357, 9876.35803672766, 11816.940915295454, 12117.091218158585, 4312.137572485484, 4328.43730315057, 4389.2318844202455, 4474.418325617681, 4523.909521809545, 48543.75728121372, 50409.219308552005, 50863.0, 50901.490985090044, 50959.0, 9412.764680882896, 9415.764605884771, 9598.944116147219, 9768.804623907483, 10042.849357259647, 17799.644007119787, 17847.28610855577, 17882.821171788375, 17904.373346932796, 17941.551461213312, 7560.508566943131, 7607.35337496319, 7721.729739459204, 7726.38188944883, 8047.396445266629, 4562.703424277478, 4641.489436162019, 4661.86014419568, 4737.95262047382, 4928.408590969107, 3087.1356020314347, 3106.39425312062, 3118.3139709263924, 3127.859246333875, 3141.3403185331335, 592.2389729198046, 595.9150026567901, 597.5996082624652, 603.8218725475995, 605.7970579855797, 486.33615115367974, 618.5608218165153, 636.6784773689258, 638.5913015669975, 662.8144119646506, 8700.52147131901, 8821.911780882238, 8847.690330838519, 8896.8665470018, 8902.109789021175, 625.7321214098216, 631.6904716688789, 635.4376376906471, 665.70043480434, 674.254948282151, 4025.1345960618023, 4052.9594704052583, 4140.772257525865, 4186.665066794649, 4265.872023839228, 61477.31533558305, 63767.0, 64648.35351646518, 64748.0, 64764.67617661976, 48460.515394846305, 48504.27243591349, 49801.750991244815, 54268.45731542713, 54457.0, 45178.32232516515, 47516.5248347519, 47570.28644570334, 48149.27776083362, 48354.0, 8697.913020869963, 8742.912570874465, 8832.160944710242, 9038.819223615623, 9055.36612437123, 34666.0, 34782.304353913285, 35026.299474009866, 35028.12429689278, 36083.63916360908, 41741.0, 42384.78807605942, 42766.57233427626, 47127.293090604355, 47144.52855471538, 11184.664460066211, 11200.271982321448, 11395.829062563902, 11665.941670291595, 11762.823557646814, 12136.878631213927, 12357.0, 12364.690882727644, 12851.228926264454, 12875.549355772877, 11132.619135574436, 11226.719332016764, 11655.0, 11671.824922626338, 11691.0, 10814.243002989715, 10839.729006774895, 11109.777804444027, 11761.117916156494, 11842.637692019483, 11486.310821350746, 11763.705907352385, 11789.351585662527, 11877.465514051715, 12099.33453660057, 10086.243531735296, 10410.947945260225, 10497.895021049997, 10587.153027757608, 10723.0, 9480.445645777469, 9675.433632184571, 9832.410055396698, 10114.949425252827, 10335.328203666737], "unit": "score", "name": "yui.html", "value": 6421.149526676896}], "name": "dromaeo_css", "value": 6873.387466195173}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 111.0, 108.0, 111.0, 111.0, 110.0, 98.0, 109.0, 110.0, 109.0], "unit": "score", "name": "ai-astar", "value": 108.8}, {"lowerIsBetter": true, "replicates": [156.0, 129.0, 150.0, 167.0, 128.0, 152.0, 149.0, 128.0, 168.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 145.4}, {"lowerIsBetter": true, "replicates": [160.0, 162.0, 159.0, 160.0, 159.0, 159.0, 159.0, 165.0, 161.0, 160.0], "unit": "score", "name": "audio-dft", "value": 160.4}, {"lowerIsBetter": true, "replicates": [73.0, 76.0, 99.0, 102.0, 75.0, 75.0, 75.0, 121.0, 96.0, 75.0], "unit": "score", "name": "audio-fft", "value": 86.7}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 149.0, 93.0, 93.0, 93.0, 139.0, 94.0, 93.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 108.1}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.9}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 144.0, 145.0, 145.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.0}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [60.0, 57.0, 57.0, 58.0, 56.0, 59.0, 58.0, 67.0, 57.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 58.4}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 68.0, 68.0, 69.0, 68.0, 69.0, 69.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [91.0, 82.0, 82.0, 82.0, 83.0, 80.0, 81.0, 81.0, 81.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.5}, {"lowerIsBetter": true, "replicates": [117.0, 130.0, 115.0, 113.0, 123.0, 114.0, 113.0, 116.0, 118.0, 113.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.2}, {"lowerIsBetter": true, "replicates": [152.0, 133.0, 130.0, 140.0, 142.0, 131.0, 140.0, 140.0, 146.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 139.5}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 70.0, 68.0, 67.0, 68.0, 67.0, 68.0, 68.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.4}], "name": "kraken", "value": 1500.0}]} 08:29:19 INFO - Return code: 0 08:29:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 08:29:19 ERROR - # TBPL SUCCESS # 08:29:19 INFO - Running post-action listener: _resource_record_post_action 08:29:19 INFO - Running post-run listener: _resource_record_post_run 08:29:20 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 73728; Write bytes: 365854720; Read time: 20; Write time: 379160 08:29:20 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 76218368; Read time: 0; Write time: 60684 08:29:20 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 73728; Write bytes: 287137792; Read time: 20; Write time: 318184 08:29:20 INFO - Running post-run listener: _upload_blobber_files 08:29:20 INFO - Blob upload gear active. 08:29:20 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 08:29:20 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:29:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 08:29:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 08:29:20 INFO - (blobuploader) - INFO - Open directory for files ... 08:29:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 08:29:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:29:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:29:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:29:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:29:21 INFO - (blobuploader) - INFO - Done attempting. 08:29:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:29:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:29:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:29:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:29:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:29:22 INFO - (blobuploader) - INFO - Done attempting. 08:29:22 INFO - (blobuploader) - INFO - Iteration through files over. 08:29:22 INFO - Return code: 0 08:29:22 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 08:29:22 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 08:29:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b64140a3e02c2b5df2721403ecebd46eab0ec5e7b411fa20fd607c218efa1d1f1af5abdebe64ac459a05c3496f64c63460219256dc823624a405e047bf7672f4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d080ac5b290d65a65c8b3875e3cab8fe11003c09af4d03c903097df3ddebf5a7164f6ed377152b5906f12161e628316ed3d1456d42caec1081b17e79047a001e"} 08:29:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 08:29:22 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 08:29:22 INFO - Contents: 08:29:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b64140a3e02c2b5df2721403ecebd46eab0ec5e7b411fa20fd607c218efa1d1f1af5abdebe64ac459a05c3496f64c63460219256dc823624a405e047bf7672f4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d080ac5b290d65a65c8b3875e3cab8fe11003c09af4d03c903097df3ddebf5a7164f6ed377152b5906f12161e628316ed3d1456d42caec1081b17e79047a001e"} 08:29:22 INFO - Running post-run listener: copy_logs_to_upload_dir 08:29:22 INFO - Copying logs to upload dir... 08:29:22 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 08:29:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.831632 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-03-11 08:29:22.115361) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-11 08:29:22.119103) ========= 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=7de08804244eb36560b44971000001c3-1457712522.837059-206446385 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b64140a3e02c2b5df2721403ecebd46eab0ec5e7b411fa20fd607c218efa1d1f1af5abdebe64ac459a05c3496f64c63460219256dc823624a405e047bf7672f4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d080ac5b290d65a65c8b3875e3cab8fe11003c09af4d03c903097df3ddebf5a7164f6ed377152b5906f12161e628316ed3d1456d42caec1081b17e79047a001e"} build_url:https://queue.taskcluster.net/v1/task/EymNfJgBS76aErO5LXsoig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011265 build_url: 'https://queue.taskcluster.net/v1/task/EymNfJgBS76aErO5LXsoig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b64140a3e02c2b5df2721403ecebd46eab0ec5e7b411fa20fd607c218efa1d1f1af5abdebe64ac459a05c3496f64c63460219256dc823624a405e047bf7672f4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d080ac5b290d65a65c8b3875e3cab8fe11003c09af4d03c903097df3ddebf5a7164f6ed377152b5906f12161e628316ed3d1456d42caec1081b17e79047a001e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-11 08:29:22.145246) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 08:29:22.145742) ========= 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=7de08804244eb36560b44971000001c3-1457712522.837059-206446385 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004735 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 08:29:22.198889) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-11 08:29:22.199536) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-11 08:29:22.200268) ========= ========= Total master_lag: 0.26 =========