builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-013 starttime: 1458551343.25 results: success (0) buildid: 20160320233036 builduid: d768ac71418244efbfa60e97d7b21d42 revision: e10424cf620fabac9a0850668bff5875583402f0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-21 02:09:03.251852) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-21 02:09:03.252384) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-21 02:09:03.252737) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1458551342.828594-144312879 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005088 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-21 02:09:03.274996) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-21 02:09:03.275338) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-21 02:09:03.305104) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 02:09:03.305832) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1458551342.828594-144312879 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.030732 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 02:09:03.356534) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-21 02:09:03.356859) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-21 02:09:03.357309) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 02:09:03.357618) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1458551342.828594-144312879 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-21 02:09:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2016-03-21 02:09:03 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.093221 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 02:09:03.466715) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 02:09:03.467456) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1458551342.828594-144312879 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.137540 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 02:09:03.620622) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-21 02:09:03.621470) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e10424cf620fabac9a0850668bff5875583402f0 --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 e10424cf620fabac9a0850668bff5875583402f0 --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=9c3a94c35cc88655b05d2c08000001b2-1458551342.828594-144312879 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-21 02:09:03,883 truncating revision to first 12 chars 2016-03-21 02:09:03,883 Setting DEBUG logging. 2016-03-21 02:09:03,883 attempt 1/10 2016-03-21 02:09:03,883 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e10424cf620f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-21 02:09:04,733 unpacking tar archive at: fx-team-e10424cf620f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.141964 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-21 02:09:04.780442) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-21 02:09:04.781300) ========= echo e10424cf620fabac9a0850668bff5875583402f0 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'e10424cf620fabac9a0850668bff5875583402f0'] 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=9c3a94c35cc88655b05d2c08000001b2-1458551342.828594-144312879 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False e10424cf620fabac9a0850668bff5875583402f0 program finished with exit code 0 elapsedTime=0.004723 script_repo_revision: 'e10424cf620fabac9a0850668bff5875583402f0' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-21 02:09:04.835582) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-21 02:09:04.835914) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-21 02:09:04.846241) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-03-21 02:09:04.846589) ========= /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=9c3a94c35cc88655b05d2c08000001b2-1458551342.828594-144312879 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:09:05 INFO - MultiFileLogger online at 20160321 02:09:05 in /builds/slave/test-pgo 02:09:05 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 02:09:05 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 02:09:05 INFO - {'append_to_log': False, 02:09:05 INFO - 'base_work_dir': '/builds/slave/test-pgo', 02:09:05 INFO - 'blob_upload_branch': 'Fx-Team', 02:09:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 02:09:05 INFO - 'branch': 'Fx-Team', 02:09:05 INFO - 'buildbot_json_path': 'buildprops.json', 02:09:05 INFO - 'config_files': ('talos/linux_config.py',), 02:09:05 INFO - 'default_actions': ('clobber', 02:09:05 INFO - 'read-buildbot-config', 02:09:05 INFO - 'download-and-extract', 02:09:05 INFO - 'populate-webroot', 02:09:05 INFO - 'create-virtualenv', 02:09:05 INFO - 'install', 02:09:05 INFO - 'run-tests'), 02:09:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:09:05 INFO - 'download_minidump_stackwalk': True, 02:09:05 INFO - 'download_symbols': 'ondemand', 02:09:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:09:05 INFO - 'tooltool.py': '/tools/tooltool.py', 02:09:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:09:05 INFO - '/tools/misc-python/virtualenv.py')}, 02:09:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:09:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:09:05 INFO - 'installer_path': 'installer.exe', 02:09:05 INFO - 'log_level': 'info', 02:09:05 INFO - 'log_name': 'talos', 02:09:05 INFO - 'log_to_console': True, 02:09:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:09:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:09:05 INFO - 'opt_config_files': (), 02:09:05 INFO - 'pip_index': False, 02:09:05 INFO - 'sps_profile': False, 02:09:05 INFO - 'sps_profile_interval': 0, 02:09:05 INFO - 'suite': 'dromaeojs', 02:09:05 INFO - 'system_bits': '32', 02:09:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:09:05 INFO - 'title': 'talos-linux64-ix-013', 02:09:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:09:05 INFO - 'use_talos_json': True, 02:09:05 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 02:09:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:09:05 INFO - 'work_dir': 'build'} 02:09:05 INFO - ##### 02:09:05 INFO - ##### Running clobber step. 02:09:05 INFO - ##### 02:09:05 INFO - Running pre-action listener: _resource_record_pre_action 02:09:05 INFO - Running main action method: clobber 02:09:05 INFO - rmtree: /builds/slave/test-pgo/build 02:09:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 02:09:09 INFO - Running post-action listener: _resource_record_post_action 02:09:09 INFO - ##### 02:09:09 INFO - ##### Running read-buildbot-config step. 02:09:09 INFO - ##### 02:09:09 INFO - Running pre-action listener: _resource_record_pre_action 02:09:09 INFO - Running main action method: read_buildbot_config 02:09:09 INFO - Using buildbot properties: 02:09:09 INFO - { 02:09:09 INFO - "project": "", 02:09:09 INFO - "product": "firefox", 02:09:09 INFO - "script_repo_revision": "production", 02:09:09 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:09:09 INFO - "repository": "", 02:09:09 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 02:09:09 INFO - "buildid": "20160320233036", 02:09:09 INFO - "pgo_build": "True", 02:09:09 INFO - "basedir": "/builds/slave/test-pgo", 02:09:09 INFO - "buildnumber": 732, 02:09:09 INFO - "slavename": "talos-linux64-ix-013", 02:09:09 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:09:09 INFO - "platform": "ubuntu64_hw", 02:09:09 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:09:09 INFO - "branch": "fx-team", 02:09:09 INFO - "repo_path": "integration/fx-team", 02:09:09 INFO - "revision": "e10424cf620fabac9a0850668bff5875583402f0", 02:09:09 INFO - "stage_platform": "linux64-pgo", 02:09:09 INFO - "builduid": "d768ac71418244efbfa60e97d7b21d42", 02:09:09 INFO - "slavebuilddir": "test" 02:09:09 INFO - } 02:09:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/GxI6FjqiT6-Odrfgs9ELxg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 02:09:09 INFO - Running post-action listener: _resource_record_post_action 02:09:09 INFO - ##### 02:09:09 INFO - ##### Running download-and-extract step. 02:09:09 INFO - ##### 02:09:09 INFO - Running pre-action listener: _resource_record_pre_action 02:09:09 INFO - Running main action method: download_and_extract 02:09:09 INFO - mkdir: /builds/slave/test-pgo/build/tests 02: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')]} 02:09:09 INFO - https://queue.taskcluster.net/v1/task/GxI6FjqiT6-Odrfgs9ELxg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:09:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GxI6FjqiT6-Odrfgs9ELxg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:09:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GxI6FjqiT6-Odrfgs9ELxg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:09:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GxI6FjqiT6-Odrfgs9ELxg/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 02:09:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GxI6FjqiT6-Odrfgs9ELxg/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 02:09:10 INFO - Downloaded 1361 bytes. 02:09:10 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:09:10 INFO - Using the following test package requirements: 02:09:10 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 02:09:10 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:09:10 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:09:10 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:09:10 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:09:10 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:09:10 INFO - u'jsshell-linux-x86_64.zip'], 02:09:10 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:09:10 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:09:10 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 02:09:10 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:09:10 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:09:10 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:09:10 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:09:10 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:09:10 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:09:10 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:09:10 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:09:10 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:09:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:09:10 INFO - https://queue.taskcluster.net/v1/task/GxI6FjqiT6-Odrfgs9ELxg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:09:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GxI6FjqiT6-Odrfgs9ELxg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:09:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GxI6FjqiT6-Odrfgs9ELxg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:09:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GxI6FjqiT6-Odrfgs9ELxg/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 02:09:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GxI6FjqiT6-Odrfgs9ELxg/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 02:09:11 INFO - Downloaded 23570272 bytes. 02:09:11 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'] 02:09:11 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 02:09:12 INFO - Return code: 0 02:09:12 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 02:09:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:09:12 INFO - https://queue.taskcluster.net/v1/task/GxI6FjqiT6-Odrfgs9ELxg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:09:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GxI6FjqiT6-Odrfgs9ELxg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:09:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GxI6FjqiT6-Odrfgs9ELxg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:09:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GxI6FjqiT6-Odrfgs9ELxg/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 02:09:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GxI6FjqiT6-Odrfgs9ELxg/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 02:09:13 INFO - Downloaded 23570272 bytes. 02:09:13 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'] 02:09:13 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 02:09:14 INFO - Return code: 0 02:09:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:09:14 INFO - https://queue.taskcluster.net/v1/task/GxI6FjqiT6-Odrfgs9ELxg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:09:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GxI6FjqiT6-Odrfgs9ELxg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 02:09:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GxI6FjqiT6-Odrfgs9ELxg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 02:09:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GxI6FjqiT6-Odrfgs9ELxg/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 02:09:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GxI6FjqiT6-Odrfgs9ELxg/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 02:09:16 INFO - Downloaded 10847637 bytes. 02:09:16 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'] 02:09:16 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 02:09:16 INFO - Return code: 0 02:09:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:09:16 INFO - https://queue.taskcluster.net/v1/task/GxI6FjqiT6-Odrfgs9ELxg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:09:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GxI6FjqiT6-Odrfgs9ELxg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:09:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GxI6FjqiT6-Odrfgs9ELxg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:09:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GxI6FjqiT6-Odrfgs9ELxg/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 02:09:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GxI6FjqiT6-Odrfgs9ELxg/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 02:09:17 INFO - Downloaded 57750727 bytes. 02:09:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GxI6FjqiT6-Odrfgs9ELxg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:09:17 INFO - mkdir: /builds/slave/test-pgo/properties 02:09:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 02:09:17 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 02:09:17 INFO - Contents: 02:09:17 INFO - build_url:https://queue.taskcluster.net/v1/task/GxI6FjqiT6-Odrfgs9ELxg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:09:18 INFO - Running post-action listener: _resource_record_post_action 02:09:18 INFO - Running post-action listener: set_extra_try_arguments 02:09:18 INFO - ##### 02:09:18 INFO - ##### Running populate-webroot step. 02:09:18 INFO - ##### 02:09:18 INFO - Running pre-action listener: _resource_record_pre_action 02:09:18 INFO - Running main action method: populate_webroot 02:09:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:09:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:09:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:09:18 INFO - '--tppagecycles', 02:09:18 INFO - '7'], 02:09:18 INFO - 'tests': ['tsvgm']}}, 02:09:18 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:09:18 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:09:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:09:18 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 02:09:18 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:09:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:09:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:09:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:09:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:09:18 INFO - 'talos_options': ['--e10s'], 02:09:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:09:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:09:18 INFO - 'tests': ['damp', 'tps']}, 02:09:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:09:18 INFO - 'talos_options': ['--e10s'], 02:09:18 INFO - 'tests': ['damp', 'tps']}, 02:09:18 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:09:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:09:18 INFO - 'other': {'tests': ['a11yr', 02:09:18 INFO - 'ts_paint', 02:09:18 INFO - 'tpaint', 02:09:18 INFO - 'sessionrestore', 02:09:18 INFO - 'sessionrestore_no_auto_restore', 02:09:18 INFO - 'tabpaint']}, 02:09:18 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:09:18 INFO - 'tests': ['a11yr', 02:09:18 INFO - 'ts_paint', 02:09:18 INFO - 'tpaint', 02:09:18 INFO - 'sessionrestore', 02:09:18 INFO - 'sessionrestore_no_auto_restore', 02:09:18 INFO - 'tabpaint']}, 02:09:18 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:09:18 INFO - 'tests': ['a11yr', 02:09:18 INFO - 'ts_paint', 02:09:18 INFO - 'tpaint', 02:09:18 INFO - 'sessionrestore', 02:09:18 INFO - 'sessionrestore_no_auto_restore', 02:09:18 INFO - 'tabpaint']}, 02:09:18 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:09:18 INFO - 'tests': ['a11yr', 02:09:18 INFO - 'ts_paint', 02:09:18 INFO - 'tpaint', 02:09:18 INFO - 'sessionrestore', 02:09:18 INFO - 'sessionrestore_no_auto_restore', 02:09:18 INFO - 'tabpaint']}, 02:09:18 INFO - 'other_l64': {'tests': ['a11yr', 02:09:18 INFO - 'ts_paint', 02:09:18 INFO - 'tpaint', 02:09:18 INFO - 'sessionrestore', 02:09:18 INFO - 'sessionrestore_no_auto_restore', 02:09:18 INFO - 'tabpaint']}, 02:09:18 INFO - 'other_nol64': {'tests': ['a11yr', 02:09:18 INFO - 'ts_paint', 02:09:18 INFO - 'tpaint', 02:09:18 INFO - 'sessionrestore', 02:09:18 INFO - 'sessionrestore_no_auto_restore', 02:09:18 INFO - 'tabpaint']}, 02:09:18 INFO - 'svgr': {'tests': ['tsvgx', 02:09:18 INFO - 'tsvgr_opacity', 02:09:18 INFO - 'tart', 02:09:18 INFO - 'tscrollx', 02:09:18 INFO - 'cart']}, 02:09:18 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:09:18 INFO - 'tests': ['tsvgx', 02:09:18 INFO - 'tsvgr_opacity', 02:09:18 INFO - 'tart', 02:09:18 INFO - 'tscrollx', 02:09:18 INFO - 'cart']}, 02:09:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:09:18 INFO - 'tests': ['tp5o']}, 02:09:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:09:18 INFO - 'talos_options': ['--e10s'], 02:09:18 INFO - 'tests': ['tp5o']}, 02:09:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:09:18 INFO - 'talos_options': ['--xperf_path', 02:09:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:09:18 INFO - 'tests': ['tp5n']}, 02:09:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:09:18 INFO - 'talos_options': ['--e10s', 02:09:18 INFO - '--xperf_path', 02:09:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:09:18 INFO - 'tests': ['tp5n']}}, 02:09:18 INFO - 'talos.zip': {'path': '', 02:09:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:09:18 INFO - Running post-action listener: _resource_record_post_action 02:09:18 INFO - ##### 02:09:18 INFO - ##### Running create-virtualenv step. 02:09:18 INFO - ##### 02:09:18 INFO - Running pre-action listener: _resource_record_pre_action 02:09:18 INFO - Running main action method: create_virtualenv 02:09:18 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 02:09:18 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 02:09:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 02:09:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:09:18 INFO - Using real prefix '/usr' 02:09:18 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 02:09:19 INFO - Installing distribute.............................................................................................................................................................................................done. 02:09:20 INFO - Installing pip.................done. 02:09:20 INFO - Return code: 0 02:09:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 02:09:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:09:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:09:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:20 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f743d6c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153b6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15361d0>, '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 0x1539750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1539be0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1458551342.828594-144312879', '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 02:09:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 02:09:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:09:20 INFO - Using env: {'DISPLAY': ':0', 02:09:20 INFO - 'HOME': '/home/cltbld', 02:09:20 INFO - 'LANG': 'en_US.UTF-8', 02:09:20 INFO - 'LANGUAGE': 'en_US:en', 02:09:20 INFO - 'LOGNAME': 'cltbld', 02:09:20 INFO - 'MAIL': '/var/mail/cltbld', 02:09:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:20 INFO - 'MOZ_NO_REMOTE': '1', 02:09:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:09:20 INFO - 'NO_EM_RESTART': '1', 02:09:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:09:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:09:21 INFO - 'PWD': '/builds/slave/test-pgo', 02:09:21 INFO - 'SHELL': '/bin/bash', 02:09:21 INFO - 'SHLVL': '1', 02:09:21 INFO - 'TERM': 'linux', 02:09:21 INFO - 'TMOUT': '86400', 02:09:21 INFO - 'USER': 'cltbld', 02:09:21 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1458551342.828594-144312879', 02:09:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:21 INFO - '_': '/tools/buildbot/bin/python'} 02:09:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:21 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 02:09:21 INFO - Cleaning up... 02:09:21 INFO - Return code: 0 02:09:21 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 02:09:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:09:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:21 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f743d6c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153b6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15361d0>, '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 0x1539750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1539be0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1458551342.828594-144312879', '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 02:09:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 02:09:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:09:21 INFO - Using env: {'DISPLAY': ':0', 02:09:21 INFO - 'HOME': '/home/cltbld', 02:09:21 INFO - 'LANG': 'en_US.UTF-8', 02:09:21 INFO - 'LANGUAGE': 'en_US:en', 02:09:21 INFO - 'LOGNAME': 'cltbld', 02:09:21 INFO - 'MAIL': '/var/mail/cltbld', 02:09:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:21 INFO - 'MOZ_NO_REMOTE': '1', 02:09:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:09:21 INFO - 'NO_EM_RESTART': '1', 02:09:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:09:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:09:21 INFO - 'PWD': '/builds/slave/test-pgo', 02:09:21 INFO - 'SHELL': '/bin/bash', 02:09:21 INFO - 'SHLVL': '1', 02:09:21 INFO - 'TERM': 'linux', 02:09:21 INFO - 'TMOUT': '86400', 02:09:21 INFO - 'USER': 'cltbld', 02:09:21 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1458551342.828594-144312879', 02:09:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:21 INFO - '_': '/tools/buildbot/bin/python'} 02:09:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:21 INFO - Downloading/unpacking psutil>=0.7.1 02:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 02:09:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:09:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:09:23 INFO - Installing collected packages: psutil 02:09:23 INFO - Running setup.py install for psutil 02:09:23 INFO - building 'psutil._psutil_linux' extension 02:09:23 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 02:09:23 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 02:09:23 INFO - building 'psutil._psutil_posix' extension 02:09:23 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 02:09:23 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 02:09:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:09:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:09:23 INFO - Successfully installed psutil 02:09:23 INFO - Cleaning up... 02:09:23 INFO - Return code: 0 02:09:23 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 02:09:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:09:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:09:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:23 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f743d6c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153b6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15361d0>, '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 0x1539750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1539be0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1458551342.828594-144312879', '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 02:09:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 02:09:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 02:09:23 INFO - Using env: {'DISPLAY': ':0', 02:09:23 INFO - 'HOME': '/home/cltbld', 02:09:23 INFO - 'LANG': 'en_US.UTF-8', 02:09:23 INFO - 'LANGUAGE': 'en_US:en', 02:09:23 INFO - 'LOGNAME': 'cltbld', 02:09:23 INFO - 'MAIL': '/var/mail/cltbld', 02:09:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:23 INFO - 'MOZ_NO_REMOTE': '1', 02:09:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:09:23 INFO - 'NO_EM_RESTART': '1', 02:09:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:09:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:09:23 INFO - 'PWD': '/builds/slave/test-pgo', 02:09:23 INFO - 'SHELL': '/bin/bash', 02:09:23 INFO - 'SHLVL': '1', 02:09:23 INFO - 'TERM': 'linux', 02:09:23 INFO - 'TMOUT': '86400', 02:09:23 INFO - 'USER': 'cltbld', 02:09:23 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1458551342.828594-144312879', 02:09:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:23 INFO - '_': '/tools/buildbot/bin/python'} 02:09:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:24 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02: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 02: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 02: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 02: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 02: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 02: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 02:09:25 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:09:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:09:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:09:26 INFO - Installing collected packages: mozsystemmonitor 02:09:26 INFO - Running setup.py install for mozsystemmonitor 02:09:26 INFO - Successfully installed mozsystemmonitor 02:09:26 INFO - Cleaning up... 02:09:26 INFO - Return code: 0 02:09:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 02:09:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:09:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:26 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 0x7f743d6c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153b6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15361d0>, '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 0x1539750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1539be0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1458551342.828594-144312879', '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 02:09:26 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 02:09:26 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 02:09:26 INFO - Using env: {'DISPLAY': ':0', 02:09:26 INFO - 'HOME': '/home/cltbld', 02:09:26 INFO - 'LANG': 'en_US.UTF-8', 02:09:26 INFO - 'LANGUAGE': 'en_US:en', 02:09:26 INFO - 'LOGNAME': 'cltbld', 02:09:26 INFO - 'MAIL': '/var/mail/cltbld', 02:09:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:26 INFO - 'MOZ_NO_REMOTE': '1', 02:09:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:09:26 INFO - 'NO_EM_RESTART': '1', 02:09:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:09:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:09:26 INFO - 'PWD': '/builds/slave/test-pgo', 02:09:26 INFO - 'SHELL': '/bin/bash', 02:09:26 INFO - 'SHLVL': '1', 02:09:26 INFO - 'TERM': 'linux', 02:09:26 INFO - 'TMOUT': '86400', 02:09:26 INFO - 'USER': 'cltbld', 02:09:26 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1458551342.828594-144312879', 02:09:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:26 INFO - '_': '/tools/buildbot/bin/python'} 02:09:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:26 INFO - Downloading/unpacking blobuploader==1.2.4 02:09:26 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 02:09:26 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 02:09:26 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 02:09:26 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 02:09:26 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 02:09:26 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 02:09:28 INFO - Downloading blobuploader-1.2.4.tar.gz 02:09:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:09:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:09:28 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 02:09:28 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 02:09:28 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 02:09:28 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 02:09:28 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 02:09:28 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 02:09:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 02:09:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:09:28 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 02:09:28 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 02:09:28 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 02:09:28 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 02:09:28 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 02:09:28 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 02:09:28 INFO - Downloading docopt-0.6.1.tar.gz 02:09:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 02:09:29 INFO - Installing collected packages: blobuploader, requests, docopt 02:09:29 INFO - Running setup.py install for blobuploader 02:09:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:09:29 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 02:09:29 INFO - Running setup.py install for requests 02:09:29 INFO - Running setup.py install for docopt 02:09:29 INFO - Successfully installed blobuploader requests docopt 02:09:29 INFO - Cleaning up... 02:09:29 INFO - Return code: 0 02:09:29 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:09:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:09:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:09:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:29 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 0x7f743d6c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153b6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15361d0>, '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 0x1539750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1539be0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1458551342.828594-144312879', '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 02:09:29 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 02:09:29 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 02:09:29 INFO - Using env: {'DISPLAY': ':0', 02:09:29 INFO - 'HOME': '/home/cltbld', 02:09:29 INFO - 'LANG': 'en_US.UTF-8', 02:09:29 INFO - 'LANGUAGE': 'en_US:en', 02:09:29 INFO - 'LOGNAME': 'cltbld', 02:09:29 INFO - 'MAIL': '/var/mail/cltbld', 02:09:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:29 INFO - 'MOZ_NO_REMOTE': '1', 02:09:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:09:29 INFO - 'NO_EM_RESTART': '1', 02:09:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:09:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:09:29 INFO - 'PWD': '/builds/slave/test-pgo', 02:09:29 INFO - 'SHELL': '/bin/bash', 02:09:29 INFO - 'SHLVL': '1', 02:09:29 INFO - 'TERM': 'linux', 02:09:29 INFO - 'TMOUT': '86400', 02:09:29 INFO - 'USER': 'cltbld', 02:09:29 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1458551342.828594-144312879', 02:09:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:29 INFO - '_': '/tools/buildbot/bin/python'} 02:09:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:09:29 INFO - Running setup.py (path:/tmp/pip-zip848-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:09:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:09:29 INFO - Running setup.py (path:/tmp/pip-BF2Cat-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:09:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:09:29 INFO - Running setup.py (path:/tmp/pip-sTQoUX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:09:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:09:30 INFO - Running setup.py (path:/tmp/pip-HwvuFS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:09:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 02:09:30 INFO - Running setup.py (path:/tmp/pip-wb8ZvM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 02:09:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:09:30 INFO - Running setup.py (path:/tmp/pip-kknB3W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:09:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:09:30 INFO - Running setup.py (path:/tmp/pip-6NUVj3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:09:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:09:30 INFO - Running setup.py (path:/tmp/pip-pFXvRk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:09:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 02:09:30 INFO - Running setup.py (path:/tmp/pip-cUHTVF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 02:09:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 02:09:30 INFO - Running setup.py (path:/tmp/pip-qIhJ3P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 02:09:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:09:30 INFO - Running setup.py (path:/tmp/pip-W8lfxh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:09:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:09:30 INFO - Running setup.py (path:/tmp/pip-XB5uKM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:09:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:09:30 INFO - Running setup.py (path:/tmp/pip-7HYfDJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:09:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:09:30 INFO - Running setup.py (path:/tmp/pip-EuwGzj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:09:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:09:30 INFO - Running setup.py (path:/tmp/pip-L6j1nR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:09:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 02:09:30 INFO - Running setup.py (path:/tmp/pip-vdlFD6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 02:09:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 02:09:30 INFO - Running setup.py (path:/tmp/pip-iifUX7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 02:09:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:09:31 INFO - Running setup.py install for manifestparser 02:09:31 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 02:09:31 INFO - Running setup.py install for mozcrash 02:09:31 INFO - Running setup.py install for mozdebug 02:09:31 INFO - Running setup.py install for mozdevice 02:09:31 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 02:09:31 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 02:09:31 INFO - Running setup.py install for mozfile 02:09:31 INFO - Running setup.py install for mozhttpd 02:09:31 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 02:09:31 INFO - Running setup.py install for mozinfo 02:09:31 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 02:09:31 INFO - Running setup.py install for mozInstall 02:09:31 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 02:09:31 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 02:09:31 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 02:09:31 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 02:09:31 INFO - Running setup.py install for mozleak 02:09:31 INFO - Running setup.py install for mozlog 02:09:32 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 02:09:32 INFO - Running setup.py install for moznetwork 02:09:32 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 02:09:32 INFO - Running setup.py install for mozprocess 02:09:32 INFO - Running setup.py install for mozprofile 02:09:32 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 02:09:32 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 02:09:32 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 02:09:32 INFO - Running setup.py install for mozrunner 02:09:32 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 02:09:32 INFO - Running setup.py install for mozscreenshot 02:09:32 INFO - Running setup.py install for moztest 02:09:32 INFO - Running setup.py install for mozversion 02:09:32 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 02:09:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:09:32 INFO - Cleaning up... 02:09:32 INFO - Return code: 0 02:09:32 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:09:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:09:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:09:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:32 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 0x7f743d6c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153b6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15361d0>, '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 0x1539750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1539be0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1458551342.828594-144312879', '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 02:09:32 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 02:09:32 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 02:09:32 INFO - Using env: {'DISPLAY': ':0', 02:09:32 INFO - 'HOME': '/home/cltbld', 02:09:32 INFO - 'LANG': 'en_US.UTF-8', 02:09:32 INFO - 'LANGUAGE': 'en_US:en', 02:09:32 INFO - 'LOGNAME': 'cltbld', 02:09:32 INFO - 'MAIL': '/var/mail/cltbld', 02:09:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:32 INFO - 'MOZ_NO_REMOTE': '1', 02:09:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:09:32 INFO - 'NO_EM_RESTART': '1', 02:09:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:09:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:09:32 INFO - 'PWD': '/builds/slave/test-pgo', 02:09:32 INFO - 'SHELL': '/bin/bash', 02:09:32 INFO - 'SHLVL': '1', 02:09:32 INFO - 'TERM': 'linux', 02:09:32 INFO - 'TMOUT': '86400', 02:09:32 INFO - 'USER': 'cltbld', 02:09:32 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1458551342.828594-144312879', 02:09:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:32 INFO - '_': '/tools/buildbot/bin/python'} 02:09:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:09:33 INFO - Running setup.py (path:/tmp/pip-GoSMAv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:09:33 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)) 02:09:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:09:33 INFO - Running setup.py (path:/tmp/pip-2xtIXI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:09:33 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)) 02:09:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:09:33 INFO - Running setup.py (path:/tmp/pip-o4VGof-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:09:33 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)) 02:09:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:09:33 INFO - Running setup.py (path:/tmp/pip-hqQ7zX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:09:33 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)) 02:09:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 02:09:33 INFO - Running setup.py (path:/tmp/pip-ZShcBu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 02:09:33 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)) 02:09:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:09:33 INFO - Running setup.py (path:/tmp/pip-ODxe0p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:09:33 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)) 02:09:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:09:33 INFO - Running setup.py (path:/tmp/pip-gvhcKF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:09:33 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)) 02:09:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:09:33 INFO - Running setup.py (path:/tmp/pip-GFKIM1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:09:33 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)) 02:09:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 02:09:33 INFO - Running setup.py (path:/tmp/pip-wooTzj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 02:09:33 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)) 02:09:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 02:09:33 INFO - Running setup.py (path:/tmp/pip-kwlZUH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 02:09:33 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)) 02:09:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:09:33 INFO - Running setup.py (path:/tmp/pip-e5FGtn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:09:33 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)) 02:09:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:09:33 INFO - Running setup.py (path:/tmp/pip-rcfALF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:09:33 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)) 02:09:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:09:33 INFO - Running setup.py (path:/tmp/pip-wmPu9f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:09:34 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)) 02:09:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:09:34 INFO - Running setup.py (path:/tmp/pip-0ovLvB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:09:34 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)) 02:09:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:09:34 INFO - Running setup.py (path:/tmp/pip-sWfhG3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:09:34 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)) 02:09:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 02:09:34 INFO - Running setup.py (path:/tmp/pip-vtCsX3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 02:09:34 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)) 02:09:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 02:09:34 INFO - Running setup.py (path:/tmp/pip-aAZMNe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 02:09:34 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)) 02:09:34 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)) 02:09:34 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)) 02:09:34 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)) 02:09:34 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)) 02:09:34 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)) 02:09:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 02:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:36 INFO - Downloading blessings-1.6.tar.gz 02:09:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 02:09:36 INFO - Installing collected packages: blessings 02:09:36 INFO - Running setup.py install for blessings 02:09:36 INFO - Successfully installed blessings 02:09:36 INFO - Cleaning up... 02:09:36 INFO - Return code: 0 02:09:36 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 02:09:36 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 02:09:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 02:09:36 INFO - Reading from file tmpfile_stdout 02:09:36 INFO - Current package versions: 02:09:36 INFO - argparse == 1.2.1 02:09:36 INFO - blessings == 1.6 02:09:36 INFO - blobuploader == 1.2.4 02:09:36 INFO - docopt == 0.6.1 02:09:36 INFO - manifestparser == 1.1 02:09:36 INFO - mozInstall == 1.12 02:09:36 INFO - mozcrash == 0.17 02:09:36 INFO - mozdebug == 0.1 02:09:36 INFO - mozdevice == 0.48 02:09:36 INFO - mozfile == 1.2 02:09:36 INFO - mozhttpd == 0.7 02:09:36 INFO - mozinfo == 0.9 02:09:36 INFO - mozleak == 0.1 02:09:36 INFO - mozlog == 3.1 02:09:36 INFO - moznetwork == 0.27 02:09:36 INFO - mozprocess == 0.22 02:09:36 INFO - mozprofile == 0.28 02:09:36 INFO - mozrunner == 6.11 02:09:36 INFO - mozscreenshot == 0.1 02:09:36 INFO - mozsystemmonitor == 0.0 02:09:36 INFO - moztest == 0.7 02:09:36 INFO - mozversion == 1.4 02:09:36 INFO - psutil == 3.1.1 02:09:36 INFO - requests == 1.2.3 02:09:36 INFO - wsgiref == 0.1.2 02:09:36 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:09:36 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')]} 02:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:36 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')]} 02:09:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:36 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 0x7f743d6c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153b6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15361d0>, '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 0x1539750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1539be0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1458551342.828594-144312879', '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 02:09:36 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 02:09:36 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 02:09:36 INFO - Using env: {'DISPLAY': ':0', 02:09:36 INFO - 'HOME': '/home/cltbld', 02:09:36 INFO - 'LANG': 'en_US.UTF-8', 02:09:36 INFO - 'LANGUAGE': 'en_US:en', 02:09:36 INFO - 'LOGNAME': 'cltbld', 02:09:36 INFO - 'MAIL': '/var/mail/cltbld', 02:09:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:36 INFO - 'MOZ_NO_REMOTE': '1', 02:09:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:09:36 INFO - 'NO_EM_RESTART': '1', 02:09:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:09:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:09:36 INFO - 'PWD': '/builds/slave/test-pgo', 02:09:36 INFO - 'SHELL': '/bin/bash', 02:09:36 INFO - 'SHLVL': '1', 02:09:36 INFO - 'TERM': 'linux', 02:09:36 INFO - 'TMOUT': '86400', 02:09:36 INFO - 'USER': 'cltbld', 02:09:36 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1458551342.828594-144312879', 02:09:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:36 INFO - '_': '/tools/buildbot/bin/python'} 02:09:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:36 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)) 02:09:36 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)) 02:09:36 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)) 02:09:36 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)) 02:09:36 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)) 02:09:36 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)) 02:09:36 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)) 02:09:36 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)) 02:09:36 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)) 02:09:36 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)) 02:09:36 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)) 02:09:36 INFO - Cleaning up... 02:09:36 INFO - Return code: 0 02:09:36 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 02:09:36 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')]} 02:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:36 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')]} 02:09:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:36 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 0x7f743d6c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153b6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15361d0>, '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 0x1539750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1539be0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1458551342.828594-144312879', '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 02:09:36 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 02:09:36 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 02:09:36 INFO - Using env: {'DISPLAY': ':0', 02:09:36 INFO - 'HOME': '/home/cltbld', 02:09:36 INFO - 'LANG': 'en_US.UTF-8', 02:09:36 INFO - 'LANGUAGE': 'en_US:en', 02:09:36 INFO - 'LOGNAME': 'cltbld', 02:09:36 INFO - 'MAIL': '/var/mail/cltbld', 02:09:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:36 INFO - 'MOZ_NO_REMOTE': '1', 02:09:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:09:36 INFO - 'NO_EM_RESTART': '1', 02:09:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:09:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:09:36 INFO - 'PWD': '/builds/slave/test-pgo', 02:09:36 INFO - 'SHELL': '/bin/bash', 02:09:36 INFO - 'SHLVL': '1', 02:09:36 INFO - 'TERM': 'linux', 02:09:36 INFO - 'TMOUT': '86400', 02:09:36 INFO - 'USER': 'cltbld', 02:09:36 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1458551342.828594-144312879', 02:09:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:36 INFO - '_': '/tools/buildbot/bin/python'} 02:09:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:37 INFO - Downloading/unpacking jsonschema 02:09:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:09:38 INFO - Downloading/unpacking functools32 (from jsonschema) 02:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:39 INFO - Downloading functools32-3.2.3-2.tar.gz 02:09:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 02:09:39 INFO - warning: no files found matching '*.txt' 02:09:39 INFO - no previously-included directories found matching 'build' 02:09:39 INFO - no previously-included directories found matching 'dist' 02:09:39 INFO - no previously-included directories found matching '.git*' 02:09:39 INFO - Installing collected packages: jsonschema, functools32 02:09:39 INFO - Running setup.py install for functools32 02:09:39 INFO - warning: no files found matching '*.txt' 02:09:39 INFO - no previously-included directories found matching 'build' 02:09:39 INFO - no previously-included directories found matching 'dist' 02:09:39 INFO - no previously-included directories found matching '.git*' 02:09:39 INFO - Successfully installed jsonschema functools32 02:09:39 INFO - Cleaning up... 02:09:39 INFO - Return code: 0 02:09:39 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 02:09:39 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')]} 02:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:39 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')]} 02:09:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:39 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 0x7f743d6c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153b6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15361d0>, '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 0x1539750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1539be0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1458551342.828594-144312879', '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 02:09:39 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 02:09:39 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 02:09:39 INFO - Using env: {'DISPLAY': ':0', 02:09:39 INFO - 'HOME': '/home/cltbld', 02:09:39 INFO - 'LANG': 'en_US.UTF-8', 02:09:39 INFO - 'LANGUAGE': 'en_US:en', 02:09:39 INFO - 'LOGNAME': 'cltbld', 02:09:39 INFO - 'MAIL': '/var/mail/cltbld', 02:09:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:39 INFO - 'MOZ_NO_REMOTE': '1', 02:09:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:09:39 INFO - 'NO_EM_RESTART': '1', 02:09:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:09:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:09:39 INFO - 'PWD': '/builds/slave/test-pgo', 02:09:39 INFO - 'SHELL': '/bin/bash', 02:09:39 INFO - 'SHLVL': '1', 02:09:39 INFO - 'TERM': 'linux', 02:09:39 INFO - 'TMOUT': '86400', 02:09:39 INFO - 'USER': 'cltbld', 02:09:39 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1458551342.828594-144312879', 02:09:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:39 INFO - '_': '/tools/buildbot/bin/python'} 02:09:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:39 INFO - Downloading/unpacking flake8 02:09:39 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 02:09:39 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 02:09:39 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 02:09:39 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 02:09:39 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 02:09:39 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 02:09:41 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:09:41 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:09:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 02:09:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:09:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:09:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:09:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:09:42 INFO - no previously-included directories found matching 'docs/_build' 02:09:42 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:09:42 INFO - Running setup.py install for pep8 02:09:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:09:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:09:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:09:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:09:42 INFO - no previously-included directories found matching 'docs/_build' 02:09:42 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 02:09:42 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:09:42 INFO - Cleaning up... 02:09:42 INFO - Return code: 0 02:09:42 INFO - Running post-action listener: _resource_record_post_action 02:09:42 INFO - Running post-action listener: _start_resource_monitoring 02:09:42 INFO - Starting resource monitoring. 02:09:42 INFO - ##### 02:09:42 INFO - ##### Running install step. 02:09:42 INFO - ##### 02:09:42 INFO - Running pre-action listener: _resource_record_pre_action 02:09:42 INFO - Running main action method: install 02:09:42 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 02:09:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 02:09:42 INFO - Reading from file tmpfile_stdout 02:09:42 INFO - Detecting whether we're running mozinstall >=1.0... 02:09:42 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 02:09:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 02:09:42 INFO - Reading from file tmpfile_stdout 02:09:42 INFO - Output received: 02:09:42 INFO - Usage: mozinstall [options] installer 02:09:42 INFO - Options: 02:09:42 INFO - -h, --help show this help message and exit 02:09:42 INFO - -d DEST, --destination=DEST 02:09:42 INFO - Directory to install application into. [default: 02:09:42 INFO - "/builds/slave/test-pgo"] 02:09:42 INFO - --app=APP Application being installed. [default: firefox] 02:09:42 INFO - mkdir: /builds/slave/test-pgo/build/application 02:09:42 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'] 02:09:42 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 02:09:59 INFO - Reading from file tmpfile_stdout 02:09:59 INFO - Output received: 02:09:59 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 02:09:59 INFO - Running post-action listener: _resource_record_post_action 02:09:59 INFO - ##### 02:09:59 INFO - ##### Running run-tests step. 02:09:59 INFO - ##### 02:09:59 INFO - Running pre-action listener: _resource_record_pre_action 02:09:59 INFO - Running main action method: run_tests 02:09:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 02:09:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 02:09:59 INFO - Python 2.7.3 02:09:59 INFO - Return code: 0 02:09:59 INFO - grabbing minidump binary from tooltool 02:09:59 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')]} 02:09:59 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 0x15361d0>, '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 0x1539750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1539be0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 02:09:59 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 02:09:59 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 02:09:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:09:59 INFO - Return code: 0 02:09:59 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 02:09:59 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 02:09:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 02:09:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 02:09:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 02:09:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 02:09:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 02:10:00 INFO - Return code: 0 02:10:00 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/GxI6FjqiT6-Odrfgs9ELxg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 02:10:00 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/GxI6FjqiT6-Odrfgs9ELxg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --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 02:10:00 INFO - Using env: {'DISPLAY': ':0', 02:10:00 INFO - 'HOME': '/home/cltbld', 02:10:00 INFO - 'LANG': 'en_US.UTF-8', 02:10:00 INFO - 'LANGUAGE': 'en_US:en', 02:10:00 INFO - 'LOGNAME': 'cltbld', 02:10:00 INFO - 'MAIL': '/var/mail/cltbld', 02:10:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 02:10:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 02:10:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:00 INFO - 'MOZ_NO_REMOTE': '1', 02:10:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 02:10:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:00 INFO - 'NO_EM_RESTART': '1', 02:10:00 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:10:00 INFO - 'PWD': '/builds/slave/test-pgo', 02:10:00 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 02:10:00 INFO - 'SHELL': '/bin/bash', 02:10:00 INFO - 'SHLVL': '1', 02:10:00 INFO - 'TERM': 'linux', 02:10:00 INFO - 'TMOUT': '86400', 02:10:00 INFO - 'USER': 'cltbld', 02:10:00 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1458551342.828594-144312879', 02:10:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:00 INFO - '_': '/tools/buildbot/bin/python'} 02:10:00 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/GxI6FjqiT6-Odrfgs9ELxg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 02:10:00 INFO - mozversion application_buildid: 20160320233036 02:10:00 INFO - mozversion application_changeset: e10424cf620fabac9a0850668bff5875583402f0 02:10:00 INFO - mozversion application_display_name: Nightly 02:10:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:10:00 INFO - mozversion application_name: Firefox 02:10:00 INFO - mozversion application_remotingname: firefox 02:10:00 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:10:00 INFO - mozversion application_vendor: Mozilla 02:10:00 INFO - mozversion application_version: 48.0a1 02:10:00 INFO - mozversion platform_buildid: 20160320233036 02:10:00 INFO - mozversion platform_changeset: e10424cf620fabac9a0850668bff5875583402f0 02:10:00 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:10:00 INFO - mozversion platform_version: 48.0a1 02:10:00 INFO - using testdate: 1458551400 02:10:00 INFO - actual date: 1458551400 02:10:00 INFO - starting webserver on 'localhost:49129' 02:10:00 INFO - SUITE-START | Running 2 tests 02:10:00 INFO - TEST-START | dromaeo_css 02:10:00 INFO - operating with platform_type : linux_ 02:10:00 INFO - Initialising browser for dromaeo_css test... 02:10:00 INFO - TEST-INFO | started process 12410 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQjMutz/profile http://localhost:49129/getInfo.html) 02:10:04 INFO - PROCESS | 12410 | __metrics Screen width/height:1600/1200 02:10:04 INFO - PROCESS | 12410 | colorDepth:24 02:10:04 INFO - PROCESS | 12410 | Browser inner width/height: 1024/697 02:10:04 INFO - PROCESS | 12410 | __metrics 02:10:05 ERROR - PROCESS | 12410 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:10:05 INFO - PROCESS | 12410 | 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. 02:10:06 INFO - TEST-INFO | 12410: exit 0 02:10:06 INFO - Browser initialized. 02:10:06 INFO - Running cycle 1/1 for dromaeo_css test... 02:10:06 INFO - TEST-INFO | started process 12504 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQjMutz/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:10:18 INFO - PROCESS | 12504 | RSS: Main: 154517504 02:10:18 INFO - PROCESS | 12504 | 02:11:09 INFO - PROCESS | 12504 | 1458551469043 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] 02:13:16 INFO - PROCESS | 12504 | Cycle 1(1): loaded http://localhost:49129/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49129/tests/dromaeo/cssquery-ext.html) 02:13:17 INFO - PROCESS | 12504 | RSS: Main: 265428992 02:13:17 INFO - PROCESS | 12504 | 02:16:19 INFO - PROCESS | 12504 | Cycle 1(1): loaded http://localhost:49129/tests/dromaeo/cssquery-ext.html (next: http://localhost:49129/tests/dromaeo/cssquery-jquery.html) 02:16:20 INFO - PROCESS | 12504 | RSS: Main: 235237376 02:16:20 INFO - PROCESS | 12504 | 02:19:22 INFO - PROCESS | 12504 | Cycle 1(1): loaded http://localhost:49129/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49129/tests/dromaeo/cssquery-mootools.html) 02:19:22 INFO - PROCESS | 12504 | RSS: Main: 237998080 02:19:22 INFO - PROCESS | 12504 | 02:22:24 INFO - PROCESS | 12504 | Cycle 1(1): loaded http://localhost:49129/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49129/tests/dromaeo/cssquery-prototype.html) 02:22:25 INFO - PROCESS | 12504 | RSS: Main: 221175808 02:22:25 INFO - PROCESS | 12504 | 02:25:27 INFO - PROCESS | 12504 | Cycle 1(1): loaded http://localhost:49129/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49129/tests/dromaeo/cssquery-yui.html) 02:25:28 INFO - PROCESS | 12504 | RSS: Main: 224051200 02:25:28 INFO - PROCESS | 12504 | 02:28:30 INFO - PROCESS | 12504 | Cycle 1(1): loaded http://localhost:49129/tests/dromaeo/cssquery-yui.html (next: http://localhost:49129/tests/dromaeo/cssquery-dojo.html) 02:28:30 INFO - PROCESS | 12504 | RSS: Main: 264654848 02:28:30 INFO - PROCESS | 12504 | 02:28:30 INFO - PROCESS | 12504 | __start_tp_report 02:28:30 INFO - PROCESS | 12504 | _x_x_mozilla_page_load 02:28:30 INFO - PROCESS | 12504 | _x_x_mozilla_page_load_details 02:28:30 INFO - PROCESS | 12504 | |i|pagename|runs| 02:28:30 INFO - PROCESS | 12504 | |0;dojo.html;3007.9849600751995;3072.4316001539732;3110;3112.7509799216077;3133.42031724131;5242.344706911636;5305.204219367092;5312.574994000485;5340.599455040873;5377.354717433904;5226.05930932432;5246.816361427351;5253.842384728455;5272.23552584875;5386.2997810284705;4793.712377257376;4795.424549054118;4851.175300198975;4938.135826230396;4958.181899986498;4716.316134160545;4795.184818580849;4918.5327393897705;4948.802047918079;4963.851084467454;4822.180229361017;4822.63830212732;4832.903341933159;4833.419989601271;4876.975615121937;4808.206645903421;4820.276958456225;4834.661573689843;4846.345743324641;4858.708477491362;4729.361536192604;4733.83431579893;4811.879703007417;4822.156122678517;4865.951340486586;5283.365996080456;5286.180642000496;5291;5304.867378315535;5315.681059136426;5696.832149409361;5708.058170401879;5714.485696287354;5717.656940583578;5717.771289148429;5536.778528858841;5715.171300161495;5717.342505611825;5766.567507436959;5785.074388097926;5293.285406470154;5319.813806516753;5321.574274058066;5327.573794096463;5337.866553336159;5775.711214439261;5790.276215473066;5795.88408231833;5799.217105690678;5803.216565763568;5398.811041613525;5582.637128586629;5640.746166422521;5664.433556644385;5694.487496125369;5648.604597678123;5657.915131273035;5661.915071273934;5663.065594176997;5668.858278542987;5534.833954981357;5626.718664066781;5632.718364081861;5633.492985631313;5634.690092044977;5670.603057785916;5705.5435565154685;5719.742611582489;5733.168690539848;5769.221155144086;4313.072689371737;4325.805338759764;4330.415393921843;4335.913281734411;4375.190589740908;3785.564660064073;3807.1814559869763;3835.4822099016274;3845.8846234613006;3860.9961410033034;5392.164214546751;5412.78348866041;5416.0792665247;5416.431274716098;5461.290032295776;5734.827955161351;5738.713064346766;5739.770409183586;5739.7704091836695;5745.798897038583;5309.070912590281;5343.064963631349;5382.623216374895;5449.237106805051;5456.863578410572;4928.901421971612;4932.580730637936;4933.087378834927;4951.232558953368;4968.826091086795;5949.345571987078;5953.077273022688;5956.55325850563;5960.433758792994;5974.492168165668;5544.223808666709;5709.714514274353;5763.538916886639;5776.682282474504;5786.739596718242;5954.523638109027;5962.940370596239;5967.254093238345;5968.791092311748;5969.492593129633;5639.661620302795;5642.435756424325;5660.377358490645;5667.801626943037;5672.7163641816915;5603.663780173202;5684.062129748545;5727.255456790591;5761.913571296518;5784;5605.075162598126;5608.10270356741;5618.04493236159;5620.213170156263;5628.240187574625;5427.782888684408;5530.529904958124;5574.219609254788;5575.832725018094;5587.608867379245;5473.863153421196;5502.972485137549;5504.394516603091;5515.944840551543;5547.805826796042;5530.115181570929;5558.166275058774;5559.16612508127;5585.720713964204;5586.581006424616;5356.3572371315695;5394.163904594794;5455.099908515051;5469.070258056219;5469.425710300361 02:28:30 INFO - PROCESS | 12504 | |1;ext.html;527.5753018819848;538.5314776144754;553.8310815201362;558.4527163379889;570.5806232419171;30803.691963080364;39441.80279098604;39903.810099939525;39945.80027099864;39968.80015599918;42591.14817703644;42999.71000869971;43065.56934430655;43070;43072;8595.183457571537;8793.208611224989;8794.208521233088;8795.604197811113;8797.472151670889;8624.52565108922;8717.912820871774;8734.86897696535;8735.95632021839;8742.737717868475;8727.996280427737;9007.819843603156;9024.503652299121;9031.503267320295;9032.638694452215;8922.464652120894;8980.416272942302;8985.820283594358;8988.415752976036;9000.594973226187;8829.205371516595;8939.061398553189;8952.328575356874;8952.686655967074;8964.14840590143;42706;43204;43220;43328;43331;3433.8111403872776;3526.717862571014;3694.612065733086;3860.7104467165077;4143.461350024508;30439.69560304413;31056.844715776504;31136;31610.841945790355;33066.834665826755;4215.929062150493;4297.183535128347;4328.437303150602;4328.61042506176;4375.850569040014;315962;323189;323590;323628;323699.38150309335;67161;67267.66366168235;67305.93287704818;67687.32312676909;67750;73093;75091.24908750952;75092.24907750962;75099;75116.62441687756;16969.490915272563;17212.913935430242;17215.483535493957;17215.82784172167;17216.741748873777;12299;12369.381530923418;12397.132200745862;12402.13185077054;12404.131710780339;22338.55322893533;22565.210217642303;22576.66135007976;22612.208572699878;22625.20811771613;8564.528950907636;8913.37606367548;8934.821303574023;9038.683646072355;9091.227245684191;1014.4369874719602;1037.1184493180735;1113.092829344082;1114;1165.7551914098135;31562.842185788923;33471.3305733884;35353.46969795455;35603;36324.63675363265;1082.5128692088592;1113.6046703420332;1174.8707642159357;1175.835383046374;1243.583399561139;16301.67396652084;17283.308667653404;17403;17445.65108697819;17541.210645520983;440620;454627;456334;456492;457083;59104;59468.70265648731;59529.40470595325;59549;59583.70208148932;1325.8872995795273;1403.7683782176032;1426.9357878895266;1457.6793105516558;1458.0668372241773;31012.68987310188;31354.05937821869;32740;33194.66805332012;34577.82711086429;46661.766691166325;48318;48668;48703.26945095897;48729.26906096341;276234;278056;278186;278244;278866;31977.200569985936;36651.816740916125;36977.44533832048;37024;37046.25907481889;46935.53064469311;47091.29363059625;47324.290135648684;47959;48167.277490838365;39462;39496.802515988384;39641.80179099086;39806.402903957045;42767;39240.87970763029;39880.20239595134;40510.59489405068;40945;41537;40454.19091618092;40906.1818763629;40984.79507602443;41453;41739.373909391994;33908.830455847565;36821;36997;37293.254134916606;37455.81272093622;28148.577771333858;28537.42925141527;28763.49176292412;28957.355437931026;28983.420331593672 02:28:30 INFO - PROCESS | 12504 | |2;jquery.html;354.15309162716443;359.4464524632066;359.8794403874702;362.49613037877344;366.57660402235393;17485.388011419604;18062.638747225046;19448.902755486237;19802.207911683516;19820.108095135718;17911.64176716465;18252.908735456338;19004.14481348339;19012.714809277837;19026.14382352794;5425.3760817506;5613.2422123013275;5614.635048721841;5633.183188437674;5644.5484361251;3928.0572662561067;5512.062949298629;5800.506956908668;6033.758649654009;6053.667048312341;5992.850178745544;6004.309504406983;6016.578839481238;6017.097435384683;6021.488173505258;5901.262342207224;5929.318128415222;6017.097435384683;6036.0644100164545;6049.183360246377;3690.5202323698018;5171.379434467888;5274.314339135926;5343.225232341328;5375.059364611177;20406.5918681627;20669.58660826775;20687.27594534184;22163.889180553993;22212.11151553936;2342.8828558572004;2364.7635236476385;2431.039739302983;2491.7134529528976;2551.9106831261;13680.31598420075;13927.721445571031;14036.508722194674;14304.85695143056;14407.991440599162;1955.5697746495748;2042.8467864910192;2158.4819643285655;2231.631780756173;2295.104909085458;71891.64054179747;83469.58265208696;84888;85687.7146842804;86293;17375.391861284796;17806.732899006525;18173.54566135857;18280.90859545694;18344.908275458536;28150.71849281522;28222;28364.71635283662;28475.71524284772;28569;10145;10280.537375818107;10393.116585090353;10432.530536125892;10475.423851688078;8993.505357205286;9014.819703605892;9087.545622718837;9117;9156.908430915606;8681.262092722189;8688.91311086881;8723;8801.339899507562;8803.603837827313;2828.8302701837956;3163.6712580716153;3266.2324353776844;3299.7525185610693;3363.327334533103;985.8508451575634;1009.9040591143829;1013.3970287678819;1038.8234000219982;1056.709404913655;17964.281428742703;18190.90904545469;18221;18633;18875.433736987914;959.9712008639613;997.8652881861001;1010.8584798128268;1035.435687550287;1084.7233955341337;10060;10406.323588966692;10469.84295235572;10510.684679459628;10646.254762166574;510206;516787;526241;530059;536718;85743.57128214443;86048;86336.56831715802;87375;88845;1029.3875144289286;1034.7102811212872;1051.1905832508926;1051.8054159980275;1060.490964337107;16409.09749963716;16454;16460;16468.42360517376;16510.42213522569;36938.630613693516;38021.95824334102;38958.2208355837;39330;39492;54762.45237547573;54786.45213547813;54841.451585483635;54851.45148548623;54918.725406372716;8175.1007389188335;8201.22088401601;8240.381971352053;8280.917190828255;8485.660573577235;10344.431056291976;12507.249565026128;12663.493460261487;12812.10315277959;13058.542950996669;11181.608643697431;11422.657320280405;11523.308601483937;11773.411329433322;11894.643160705193;11228.606998755004;11488.94255528717;11501.827472588086;11550.537978480766;11751.059915206592;9643.84273887138;10840.295380800539;11273.7745245093;11856.525738970344;11882.108841836724;7963.362930965393;8004.199580041949;8021.8395632088195;8046.678132874619;8150.673973041012;11173.776524469627;11772.470238839102;11783.234089784137;11814.94092529532;11853.288802671867 02:28:30 INFO - PROCESS | 12504 | |3;mootools.html;1333.6532501549607;1471.507045139878;1475.9409623615056;1620.2222932992163;1751.605888675049;7683.923160768398;7877.251661092194;7877.251661092201;7879.645415956282;7882.881756773653;7546.6981320747245;7726.768196954086;7728.574928378937;7735.4585179037485;7742.341900938427;2069;2328.7438381777993;2333.0784340185614;2357.116081469449;2376.4534157143867;2373.5134297468976;2412.8311018228733;2412.9034838606435;2413.070967677439;2415.0339864054345;2313.225069601677;2372.79831214347;2373.4303767095857;2373.6320870265135;2374.4657452073234;2323.802476789475;2330.627099664054;2378.9762102378927;2379.750126236755;2383.380321116505;2325.8720770357622;2329.5108027314286;2337.520808234308;2385.284414675608;2395.209580838319;7768.922310776877;7828.725994590162;7831.060272767248;7831.804204894866;7836.843263134705;4955.727434991074;5050.9494905051215;5060.114479965991;5068.873278168038;5070.062038522885;3387.5088112223834;3417.179876829568;3467.809270490122;3548.1307079765625;3556.1820781220463;1069.1500257295468;1098.3958822647512;1099.6096385783012;1110.639042311252;1162.9185956983015;10867.29362591437;11050.557977680883;11055.391953442557;11061.778764424667;11072.224944253825;4596.931046034245;4609.377734005933;4701.177293973541;4705.55297246761;4712.175369310357;9381.202597779265;9391.01394353583;9406.482643454676;9409.388389754644;9409.576569054409;4534.79593418297;5119.3088932994315;5164.638475306692;5168.689878607295;5173.4826517347965;4513.593776560126;4529.13946350199;4538.863834084917;4552.97723511387;4628.5371462853445;3744.1388480649057;3838.213166300902;3861.227754449121;3891.669208117342;3899.9610003900166;1244.7137158453424;1257.1137348169518;1257.5787111317627;1263.1663102352586;1274.7004453953314;1365.4469939674448;1370.260059567842;1370.5819724983776;1408.141033969278;1411.3578321863527;7522.134954480305;7710.922890771133;7712.807179820549;7714.3442807362;7714.9228507715325;471.43663322329485;478.5836322399535;483.0435737240284;487.55875932281344;490.68105731274954;6018.939810601925;6021.759129634853;6038.486728628028;6076.817695469143;6077.756889724362;9058.50178240203;9615.182709469633;9642.373245739005;9745.902540974641;9781.41311521311;9539.379940303857;9580.856287155699;9628.807423851484;9630;9637.9036209637;7357.117145942414;7559.848803024019;7569.091708994956;7639.618019099023;7643.503172293783;7286.234945330664;7327.670254838438;7343.412526997934;7344.889826652711;7412.295831895961;8459.238668519863;8725.91274087251;8739;8786.077461866413;8891.555422228992;8684;8783.78714410046;8808.823823523622;8865.68970086044;9276.211522020434;6791.117154769849;7278.854422911406;7435.405167586689;7686.57723825195;7801.375889928679;7529.4729368943645;7609.847803044019;7634.770956871303;7658.655360508679;7669.3864490841715;6717.261101278953;6862.759803407056;6876.656167191721;6955.826104347229;7018.227994920452;6738.797836064926;6750.594964302158;6777.559458635173;6945;6949.75675851363;7127.358537731629;7139.929010648444;7234.421246300389;7272.490925635155;7336;6714.83212919681;6727.764528241488;6775.525713200029;6775.864482710417;6776.390124888783;6741.59550426976;6751.662416879235;6807.523473356818;6812.080369150101;6817.522773405814 02:28:30 INFO - PROCESS | 12504 | |4;prototype.html;335.85390355195494;337.9560657114575;341.8376271271147;343.8057497513906;344.0692925636154;5965.313988891274;5972.28332600088;5989.251343582052;5992.610480318776;5996.550258730602;5901.262342207224;5971.611845230057;5981.551383646222;5983.341832398432;5983.49140323072;4388.407564978727;4449.621782148522;4530.818767249306;4577.359169716243;4605.447346318447;4569.246074397721;4572.725636461806;4582;4596.448426188846;4604.240300350438;4320.1143765527995;4534.274516077428;4539.727616343013;4540.318952157187;4542.15970045541;4428.97785511072;4509.594136527729;4531.660125490602;4554;4570.2687569988975;3999.0402303446963;4000.6999475039197;4019.97990010051;4021.2158629067344;4023.1752490739327;5765.4522820332;5775;5776.104703770922;5779.682117483537;5787.681677507735;5312.309399778004;5314;5317.308749862493;5317.335333083364;5319.521243088141;6251.812445626639;6260.373962603749;6270;6276.843078923018;6277.811665650038;4359.847405340798;4423.7566933818625;4450.26570615848;4453.819737769493;4456.799444024994;6514.739410423577;6522.510811689142;6540.542162048659;6541.378569035982;6542;4539.205639013159;4546.1135078659345;4554.294084416921;4557.680962332605;4560.475545312265;4599.33309670096;4599.67802253839;4606.447226332794;4606.608438282784;4608.677392582487;5258.237555554423;5268.236105764643;5269.1832765921345;5270.341207349082;5276.577873770089;6004.42957918997;6291.653959032205;6299.559030867796;6301.6219026858535;6317.810465686037;1566.7414876545242;1583.3508261612683;1593.219322531974;1594.194931559555;1599.856012958816;1006.3609607899036;1015.9034891685278;1029.6910926721953;1031.4017869635593;1046.9267151299337;6002.069679199731;6167.259928808572;6184.103305020837;6201.720922558496;6209.627422354673;6567.704453299613;6584.045313429526;6590.7693230736695;6591.769288074895;6593.241777195588;6175.84560385994;6180.103884936659;6181.196444462281;6182.505399568024;6186.721597528122;3487.6572519580145;3524.6122926478065;3527.488514165483;3528.594211665691;3535.416656251741;6654.733810647616;6758.459323254128;6816.897746533707;6820.624865632339;6834.316568343126;6666.96666516674;6676.599404035774;6684.398404143553;6685.832854178587;6701.6314102723845;6794.932050679528;6797.2523022467485;6808.863822723617;6812.318768123148;6814.659267036727;6552.803415897531;6553.574017688835;6558.80323590293;6558.8360290993105;6566.080748695091;6229.626222426669;6377.266614339224;6381.649009304533;6473.417392434703;6481.287058423664;6709.563878347892;6770.187577490733;6808.523403361915;6811.795646130624;6815.727370905108;4431.578999994996;4468.285074388083;4472.575105364985;4474.351219073281;4474.395956545824;6496.285408604956;6522.315156908457;6535.705893234911;6544.345565443417;6545.901811472927;6198.442140207403;6353.555251132377;6390.360963903572;6392.712327945161;6396.968015159894;6297.4647154992335;6331.968340158454;6380.617162970237;6387.041943708295;6390.7443702251385;6232.532560057924;6245.500359971283;6257.812265632038;6262.029385445263;6264.906026409516;6420.6147631142285;6435.774747883802;6437.967810160919;6438.323975982455;6446.065320528403;5868.94131058684;5981.521478281814;6072.392760723892;6257.0614407837365;6276.780312689034 02:28:30 INFO - PROCESS | 12504 | |5;yui.html;777.9260970207828;842.6418772021889;844.9619767110481;845.4377838737237;855.3029281135875;13669.7949530757;13885.097468664555;13912;13941.930290348533;13948.2328471934;15121.773173402407;15266.69466610667;15271.08373497591;15287;15296.235188240598;674.2482132422339;811.882277069826;821.876718492225;824.196408501709;824.3652387661527;808.7735434078438;828.693383448125;829.0217543298905;829.0590180145548;829.2246749289403;863.7451951674271;867.8611422172454;868.5049521772593;868.695956415256;869.026690107081;701.4493622506334;840.7141571865595;860.9827803443927;862.7282406042077;864.6887120636566;635.0696230023038;635.2789583822349;635.3170341882495;635.3805040085925;635.4693830651412;14039.64900877476;14050.508232211823;14081;14099.436022559084;14105.294735263196;13617.319134043357;14265.286735663176;14281.285935703278;14301.427942882272;14690.338934747855;10902.291351062235;11026.117910567136;11240.044596209333;11459.77080458386;11464.866456109936;3680.190358121209;3714.7585406948733;3731.3470142724914;3733.439984002421;3753.3056384568667;56776.716116419564;56868.14697779537;56882.14676779851;56999;57238;10656.360618362924;10733.963202386873;10788.298760580537;10878.184136189817;10980.396078215776;19375.8062419374;19394.5151371214;19414.805851941583;19438;19444.125014374386;7713;8032.196780321921;8038.276555110068;8118.675252989814;8207.548584827891;4665.4168228971375;4830.227163653799;4841.8547443576745;4842.806287748521;4873.610111191097;3572.499850020999;3577.928441431157;3578.7673801202836;3594.1913069559664;3598.442241452579;640.2157357237347;642.495640921874;648.3516483516484;651.1372431528245;665.0356982375574;769.5651956644477;789.7986013566504;792.426158027301;810.631162820915;832.6586099699094;9568.904310956941;9619;9734.36726612768;9756.219502439788;9817.460039697742;622.956393052482;731.8902164675235;747.8653842308437;751.4814777803298;773.2190487607556;4271.786410679453;4578.725276483422;4585.403897493371;4646.372739680168;4651.046535460223;68348;69247.30752692408;69776;69960;69965.30034699588;57851;60082;60210.698946504985;60271;61050.69474652598;50395.74802125966;50542;53650.46349536454;53939;54825;9030.407400606326;9265.72202833916;9314.48770317639;9331.580078896603;9339.20616747584;40655.39016914689;40684.59315406926;41759.164816704106;41820.79089604533;41900.371494426996;52328.21507677464;52984;53104;53754.73122634518;53845;11197.24889180449;11227.428160057761;11373;11399.544018239509;11577.536898523964;12461.314627695563;12715.682107947376;12744.235345879277;12774.552890648783;12940.352982350656;10961;11677.88322116768;12722.491100355883;13182.670433238862;13415.597532074053;11987.460564274454;12167.087468440079;12367.443465044274;12588.244705317711;12763.553275635308;12266.386680665753;12532.248065116122;12600.684982875502;12831.679208019501;12968.416421260878;10106;10139.645112421325;10217.438040907822;10244.743881403025;10574.10120139766;10408.375497470177;10615.7197386039;10827.187960902806;11044.171687123337;11245.887541124812 02:28:30 INFO - PROCESS | 12504 | __end_tp_report 02:28:30 INFO - PROCESS | 12504 | __start_cc_report 02:28:30 INFO - PROCESS | 12504 | _x_x_mozilla_cycle_collect,798 02:28:30 INFO - PROCESS | 12504 | __end_cc_report 02:28:30 INFO - PROCESS | 12504 | __startTimestamp1458552510622__endTimestamp 02:28:30 INFO - PROCESS | 12504 | 02:28:30 INFO - PROCESS | 12504 | ------- Summary: start ------- 02:28:30 INFO - PROCESS | 12504 | Number of tests: 6 02:28:30 INFO - PROCESS | 12504 | 02:28:30 INFO - PROCESS | 12504 | [#0] dojo.html Cycles:165 Average:5291.25 Median:5473.86 stddev:609.10 (11.1%) stddev-sans-first:584.04 02:28:30 INFO - PROCESS | 12504 | Values: 3008.0 3072.4 3110.0 3112.8 3133.4 5242.3 5305.2 5312.6 5340.6 5377.4 5226.1 5246.8 5253.8 5272.2 5386.3 4793.7 4795.4 4851.2 4938.1 4958.2 4716.3 4795.2 4918.5 4948.8 4963.9 4822.2 4822.6 4832.9 4833.4 4877.0 4808.2 4820.3 4834.7 4846.3 4858.7 4729.4 4733.8 4811.9 4822.2 4866.0 5283.4 5286.2 5291.0 5304.9 5315.7 5696.8 5708.1 5714.5 5717.7 5717.8 5536.8 5715.2 5717.3 5766.6 5785.1 5293.3 5319.8 5321.6 5327.6 5337.9 5775.7 5790.3 5795.9 5799.2 5803.2 5398.8 5582.6 5640.7 5664.4 5694.5 5648.6 5657.9 5661.9 5663.1 5668.9 5534.8 5626.7 5632.7 5633.5 5634.7 5670.6 5705.5 5719.7 5733.2 5769.2 4313.1 4325.8 4330.4 4335.9 4375.2 3785.6 3807.2 3835.5 3845.9 3861.0 5392.2 5412.8 5416.1 5416.4 5461.3 5734.8 5738.7 5739.8 5739.8 5745.8 5309.1 5343.1 5382.6 5449.2 5456.9 4928.9 4932.6 4933.1 4951.2 4968.8 5949.3 5953.1 5956.6 5960.4 5974.5 5544.2 5709.7 5763.5 5776.7 5786.7 5954.5 5962.9 5967.3 5968.8 5969.5 5639.7 5642.4 5660.4 5667.8 5672.7 5603.7 5684.1 5727.3 5761.9 5784.0 5605.1 5608.1 5618.0 5620.2 5628.2 5427.8 5530.5 5574.2 5575.8 5587.6 5473.9 5503.0 5504.4 5515.9 5547.8 5530.1 5558.2 5559.2 5585.7 5586.6 5356.4 5394.2 5455.1 5469.1 5469.4 02:28:30 INFO - PROCESS | 12504 | 02:28:30 INFO - PROCESS | 12504 | [#1] ext.html Cycles:180 Average:53625.90 Median:40482.39 stddev:94470.43 (233.4%) stddev-sans-first:94651.33 02:28:30 INFO - PROCESS | 12504 | Values: 527.6 538.5 553.8 558.5 570.6 30803.7 39441.8 39903.8 39945.8 39968.8 42591.1 42999.7 43065.6 43070.0 43072.0 8595.2 8793.2 8794.2 8795.6 8797.5 8624.5 8717.9 8734.9 8736.0 8742.7 8728.0 9007.8 9024.5 9031.5 9032.6 8922.5 8980.4 8985.8 8988.4 9000.6 8829.2 8939.1 8952.3 8952.7 8964.1 42706.0 43204.0 43220.0 43328.0 43331.0 3433.8 3526.7 3694.6 3860.7 4143.5 30439.7 31056.8 31136.0 31610.8 33066.8 4215.9 4297.2 4328.4 4328.6 4375.9 315962.0 323189.0 323590.0 323628.0 323699.4 67161.0 67267.7 67305.9 67687.3 67750.0 73093.0 75091.2 75092.2 75099.0 75116.6 16969.5 17212.9 17215.5 17215.8 17216.7 12299.0 12369.4 12397.1 12402.1 12404.1 22338.6 22565.2 22576.7 22612.2 22625.2 8564.5 8913.4 8934.8 9038.7 9091.2 1014.4 1037.1 1113.1 1114.0 1165.8 31562.8 33471.3 35353.5 35603.0 36324.6 1082.5 1113.6 1174.9 1175.8 1243.6 16301.7 17283.3 17403.0 17445.7 17541.2 440620.0 454627.0 456334.0 456492.0 457083.0 59104.0 59468.7 59529.4 59549.0 59583.7 1325.9 1403.8 1426.9 1457.7 1458.1 31012.7 31354.1 32740.0 33194.7 34577.8 46661.8 48318.0 48668.0 48703.3 48729.3 276234.0 278056.0 278186.0 278244.0 278866.0 31977.2 36651.8 36977.4 37024.0 37046.3 46935.5 47091.3 47324.3 47959.0 48167.3 39462.0 39496.8 39641.8 39806.4 42767.0 39240.9 39880.2 40510.6 40945.0 41537.0 40454.2 40906.2 40984.8 41453.0 41739.4 33908.8 36821.0 36997.0 37293.3 37455.8 28148.6 28537.4 28763.5 28957.4 28983.4 02:28:30 INFO - PROCESS | 12504 | 02:28:30 INFO - PROCESS | 12504 | [#2] jquery.html Cycles:180 Average:30360.72 Median:15351.31 stddev:86005.73 (560.2%) stddev-sans-first:86217.49 02:28:30 INFO - PROCESS | 12504 | Values: 354.2 359.4 359.9 362.5 366.6 17485.4 18062.6 19448.9 19802.2 19820.1 17911.6 18252.9 19004.1 19012.7 19026.1 5425.4 5613.2 5614.6 5633.2 5644.5 3928.1 5512.1 5800.5 6033.8 6053.7 5992.9 6004.3 6016.6 6017.1 6021.5 5901.3 5929.3 6017.1 6036.1 6049.2 3690.5 5171.4 5274.3 5343.2 5375.1 20406.6 20669.6 20687.3 22163.9 22212.1 2342.9 2364.8 2431.0 2491.7 2551.9 13680.3 13927.7 14036.5 14304.9 14408.0 1955.6 2042.8 2158.5 2231.6 2295.1 71891.6 83469.6 84888.0 85687.7 86293.0 17375.4 17806.7 18173.5 18280.9 18344.9 28150.7 28222.0 28364.7 28475.7 28569.0 10145.0 10280.5 10393.1 10432.5 10475.4 8993.5 9014.8 9087.5 9117.0 9156.9 8681.3 8688.9 8723.0 8801.3 8803.6 2828.8 3163.7 3266.2 3299.8 3363.3 985.9 1009.9 1013.4 1038.8 1056.7 17964.3 18190.9 18221.0 18633.0 18875.4 960.0 997.9 1010.9 1035.4 1084.7 10060.0 10406.3 10469.8 10510.7 10646.3 510206.0 516787.0 526241.0 530059.0 536718.0 85743.6 86048.0 86336.6 87375.0 88845.0 1029.4 1034.7 1051.2 1051.8 1060.5 16409.1 16454.0 16460.0 16468.4 16510.4 36938.6 38022.0 38958.2 39330.0 39492.0 54762.5 54786.5 54841.5 54851.5 54918.7 8175.1 8201.2 8240.4 8280.9 8485.7 10344.4 12507.2 12663.5 12812.1 13058.5 11181.6 11422.7 11523.3 11773.4 11894.6 11228.6 11488.9 11501.8 11550.5 11751.1 9643.8 10840.3 11273.8 11856.5 11882.1 7963.4 8004.2 8021.8 8046.7 8150.7 11173.8 11772.5 11783.2 11814.9 11853.3 02:28:30 INFO - PROCESS | 12504 | 02:28:30 INFO - PROCESS | 12504 | [#3] mootools.html Cycles:180 Average:5634.00 Median:6716.05 stddev:2897.08 (43.1%) stddev-sans-first:2887.17 02:28:30 INFO - PROCESS | 12504 | Values: 1333.7 1471.5 1475.9 1620.2 1751.6 7683.9 7877.3 7877.3 7879.6 7882.9 7546.7 7726.8 7728.6 7735.5 7742.3 2069.0 2328.7 2333.1 2357.1 2376.5 2373.5 2412.8 2412.9 2413.1 2415.0 2313.2 2372.8 2373.4 2373.6 2374.5 2323.8 2330.6 2379.0 2379.8 2383.4 2325.9 2329.5 2337.5 2385.3 2395.2 7768.9 7828.7 7831.1 7831.8 7836.8 4955.7 5050.9 5060.1 5068.9 5070.1 3387.5 3417.2 3467.8 3548.1 3556.2 1069.2 1098.4 1099.6 1110.6 1162.9 10867.3 11050.6 11055.4 11061.8 11072.2 4596.9 4609.4 4701.2 4705.6 4712.2 9381.2 9391.0 9406.5 9409.4 9409.6 4534.8 5119.3 5164.6 5168.7 5173.5 4513.6 4529.1 4538.9 4553.0 4628.5 3744.1 3838.2 3861.2 3891.7 3900.0 1244.7 1257.1 1257.6 1263.2 1274.7 1365.4 1370.3 1370.6 1408.1 1411.4 7522.1 7710.9 7712.8 7714.3 7714.9 471.4 478.6 483.0 487.6 490.7 6018.9 6021.8 6038.5 6076.8 6077.8 9058.5 9615.2 9642.4 9745.9 9781.4 9539.4 9580.9 9628.8 9630.0 9637.9 7357.1 7559.8 7569.1 7639.6 7643.5 7286.2 7327.7 7343.4 7344.9 7412.3 8459.2 8725.9 8739.0 8786.1 8891.6 8684.0 8783.8 8808.8 8865.7 9276.2 6791.1 7278.9 7435.4 7686.6 7801.4 7529.5 7609.8 7634.8 7658.7 7669.4 6717.3 6862.8 6876.7 6955.8 7018.2 6738.8 6750.6 6777.6 6945.0 6949.8 7127.4 7139.9 7234.4 7272.5 7336.0 6714.8 6727.8 6775.5 6775.9 6776.4 6741.6 6751.7 6807.5 6812.1 6817.5 02:28:30 INFO - PROCESS | 12504 | 02:28:30 INFO - PROCESS | 12504 | [#4] prototype.html Cycles:180 Average:5303.48 Median:5994.58 stddev:1602.73 (26.7%) stddev-sans-first:1563.25 02:28:30 INFO - PROCESS | 12504 | Values: 335.9 338.0 341.8 343.8 344.1 5965.3 5972.3 5989.3 5992.6 5996.6 5901.3 5971.6 5981.6 5983.3 5983.5 4388.4 4449.6 4530.8 4577.4 4605.4 4569.2 4572.7 4582.0 4596.4 4604.2 4320.1 4534.3 4539.7 4540.3 4542.2 4429.0 4509.6 4531.7 4554.0 4570.3 3999.0 4000.7 4020.0 4021.2 4023.2 5765.5 5775.0 5776.1 5779.7 5787.7 5312.3 5314.0 5317.3 5317.3 5319.5 6251.8 6260.4 6270.0 6276.8 6277.8 4359.8 4423.8 4450.3 4453.8 4456.8 6514.7 6522.5 6540.5 6541.4 6542.0 4539.2 4546.1 4554.3 4557.7 4560.5 4599.3 4599.7 4606.4 4606.6 4608.7 5258.2 5268.2 5269.2 5270.3 5276.6 6004.4 6291.7 6299.6 6301.6 6317.8 1566.7 1583.4 1593.2 1594.2 1599.9 1006.4 1015.9 1029.7 1031.4 1046.9 6002.1 6167.3 6184.1 6201.7 6209.6 6567.7 6584.0 6590.8 6591.8 6593.2 6175.8 6180.1 6181.2 6182.5 6186.7 3487.7 3524.6 3527.5 3528.6 3535.4 6654.7 6758.5 6816.9 6820.6 6834.3 6667.0 6676.6 6684.4 6685.8 6701.6 6794.9 6797.3 6808.9 6812.3 6814.7 6552.8 6553.6 6558.8 6558.8 6566.1 6229.6 6377.3 6381.6 6473.4 6481.3 6709.6 6770.2 6808.5 6811.8 6815.7 4431.6 4468.3 4472.6 4474.4 4474.4 6496.3 6522.3 6535.7 6544.3 6545.9 6198.4 6353.6 6390.4 6392.7 6397.0 6297.5 6332.0 6380.6 6387.0 6390.7 6232.5 6245.5 6257.8 6262.0 6264.9 6420.6 6435.8 6438.0 6438.3 6446.1 5868.9 5981.5 6072.4 6257.1 6276.8 02:28:30 INFO - PROCESS | 12504 | 02:28:30 INFO - PROCESS | 12504 | [#5] yui.html Cycles:180 Average:15710.45 Median:4747.82 stddev:18936.60 (398.8%) stddev-sans-first:18956.52 02:28:30 INFO - PROCESS | 12504 | Values: 777.9 842.6 845.0 845.4 855.3 13669.8 13885.1 13912.0 13941.9 13948.2 15121.8 15266.7 15271.1 15287.0 15296.2 674.2 811.9 821.9 824.2 824.4 808.8 828.7 829.0 829.1 829.2 863.7 867.9 868.5 868.7 869.0 701.4 840.7 861.0 862.7 864.7 635.1 635.3 635.3 635.4 635.5 14039.6 14050.5 14081.0 14099.4 14105.3 13617.3 14265.3 14281.3 14301.4 14690.3 10902.3 11026.1 11240.0 11459.8 11464.9 3680.2 3714.8 3731.3 3733.4 3753.3 56776.7 56868.1 56882.1 56999.0 57238.0 10656.4 10734.0 10788.3 10878.2 10980.4 19375.8 19394.5 19414.8 19438.0 19444.1 7713.0 8032.2 8038.3 8118.7 8207.5 4665.4 4830.2 4841.9 4842.8 4873.6 3572.5 3577.9 3578.8 3594.2 3598.4 640.2 642.5 648.4 651.1 665.0 769.6 789.8 792.4 810.6 832.7 9568.9 9619.0 9734.4 9756.2 9817.5 623.0 731.9 747.9 751.5 773.2 4271.8 4578.7 4585.4 4646.4 4651.0 68348.0 69247.3 69776.0 69960.0 69965.3 57851.0 60082.0 60210.7 60271.0 61050.7 50395.7 50542.0 53650.5 53939.0 54825.0 9030.4 9265.7 9314.5 9331.6 9339.2 40655.4 40684.6 41759.2 41820.8 41900.4 52328.2 52984.0 53104.0 53754.7 53845.0 11197.2 11227.4 11373.0 11399.5 11577.5 12461.3 12715.7 12744.2 12774.6 12940.4 10961.0 11677.9 12722.5 13182.7 13415.6 11987.5 12167.1 12367.4 12588.2 12763.6 12266.4 12532.2 12600.7 12831.7 12968.4 10106.0 10139.6 10217.4 10244.7 10574.1 10408.4 10615.7 10827.2 11044.2 11245.9 02:28:30 INFO - PROCESS | 12504 | -------- Summary: end -------- 02:28:30 INFO - PROCESS | 12504 | 02:28:31 INFO - TEST-INFO | 12504: exit 0 02:28:31 INFO - TEST-OK | dromaeo_css | took 1111002ms 02:28:31 INFO - TEST-START | kraken 02:28:31 INFO - operating with platform_type : linux_ 02:28:31 INFO - Initialising browser for kraken test... 02:28:31 INFO - TEST-INFO | started process 12690 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKIZUmt/profile http://localhost:49129/getInfo.html) 02:28:35 INFO - PROCESS | 12690 | __metrics Screen width/height:1600/1200 02:28:35 INFO - PROCESS | 12690 | colorDepth:24 02:28:35 INFO - PROCESS | 12690 | Browser inner width/height: 1024/697 02:28:35 INFO - PROCESS | 12690 | __metrics 02:28:36 ERROR - PROCESS | 12690 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:28:36 INFO - PROCESS | 12690 | 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. 02:28:37 INFO - TEST-INFO | 12690: exit 0 02:28:37 INFO - Browser initialized. 02:28:37 INFO - Running cycle 1/1 for kraken test... 02:28:37 INFO - TEST-INFO | started process 12771 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKIZUmt/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:28:48 INFO - PROCESS | 12771 | RSS: Main: 154521600 02:28:48 INFO - PROCESS | 12771 | 02:28:51 INFO - PROCESS | 12771 | Cycle 1(1): loaded http://localhost:49129/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49129/tests/kraken/driver.html?testName=audio-beat-detection) 02:28:52 INFO - PROCESS | 12771 | RSS: Main: 197525504 02:28:52 INFO - PROCESS | 12771 | 02:28:54 INFO - PROCESS | 12771 | Cycle 1(1): loaded http://localhost:49129/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49129/tests/kraken/driver.html?testName=audio-dft) 02:28:55 INFO - PROCESS | 12771 | RSS: Main: 186294272 02:28:55 INFO - PROCESS | 12771 | 02:28:58 INFO - PROCESS | 12771 | Cycle 1(1): loaded http://localhost:49129/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49129/tests/kraken/driver.html?testName=audio-fft) 02:28:58 INFO - PROCESS | 12771 | RSS: Main: 172032000 02:28:58 INFO - PROCESS | 12771 | 02:29:00 INFO - PROCESS | 12771 | Cycle 1(1): loaded http://localhost:49129/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49129/tests/kraken/driver.html?testName=audio-oscillator) 02:29:01 INFO - PROCESS | 12771 | RSS: Main: 173711360 02:29:01 INFO - PROCESS | 12771 | 02:29:03 INFO - PROCESS | 12771 | Cycle 1(1): loaded http://localhost:49129/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49129/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:29:04 INFO - PROCESS | 12771 | RSS: Main: 176021504 02:29:04 INFO - PROCESS | 12771 | 02:29:07 INFO - PROCESS | 12771 | Cycle 1(1): loaded http://localhost:49129/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49129/tests/kraken/driver.html?testName=imaging-darkroom) 02:29:07 INFO - PROCESS | 12771 | RSS: Main: 175755264 02:29:07 INFO - PROCESS | 12771 | 02:29:11 INFO - PROCESS | 12771 | Cycle 1(1): loaded http://localhost:49129/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49129/tests/kraken/driver.html?testName=imaging-desaturate) 02:29:11 INFO - PROCESS | 12771 | RSS: Main: 177225728 02:29:11 INFO - PROCESS | 12771 | 02:29:14 INFO - PROCESS | 12771 | Cycle 1(1): loaded http://localhost:49129/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49129/tests/kraken/driver.html?testName=json-parse-financial) 02:29:15 INFO - PROCESS | 12771 | RSS: Main: 177672192 02:29:15 INFO - PROCESS | 12771 | 02:29:16 INFO - PROCESS | 12771 | Cycle 1(1): loaded http://localhost:49129/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49129/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:29:17 INFO - PROCESS | 12771 | RSS: Main: 185651200 02:29:17 INFO - PROCESS | 12771 | 02:29:18 INFO - PROCESS | 12771 | Cycle 1(1): loaded http://localhost:49129/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49129/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:29:19 INFO - PROCESS | 12771 | RSS: Main: 184139776 02:29:19 INFO - PROCESS | 12771 | 02:29:21 INFO - PROCESS | 12771 | Cycle 1(1): loaded http://localhost:49129/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49129/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:29:22 INFO - PROCESS | 12771 | RSS: Main: 196186112 02:29:22 INFO - PROCESS | 12771 | 02:29:24 INFO - PROCESS | 12771 | Cycle 1(1): loaded http://localhost:49129/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49129/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:29:24 INFO - PROCESS | 12771 | RSS: Main: 202051584 02:29:24 INFO - PROCESS | 12771 | 02:29:27 INFO - PROCESS | 12771 | Cycle 1(1): loaded http://localhost:49129/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49129/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:29:28 INFO - PROCESS | 12771 | RSS: Main: 201564160 02:29:28 INFO - PROCESS | 12771 | 02:29:29 INFO - PROCESS | 12771 | Cycle 1(1): loaded http://localhost:49129/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49129/tests/kraken/driver.html?testName=ai-astar) 02:29:29 INFO - PROCESS | 12771 | RSS: Main: 260542464 02:29:29 INFO - PROCESS | 12771 | 02:29:29 INFO - PROCESS | 12771 | __start_tp_report 02:29:29 INFO - PROCESS | 12771 | _x_x_mozilla_page_load 02:29:29 INFO - PROCESS | 12771 | _x_x_mozilla_page_load_details 02:29:29 INFO - PROCESS | 12771 | |i|pagename|runs| 02:29:29 INFO - PROCESS | 12771 | |0;ai-astar;111;110;105;110;110;111;99;109;108;110 02:29:29 INFO - PROCESS | 12771 | |1;audio-beat-detection;156;129;149;174;126;144;160;126;182;125 02:29:29 INFO - PROCESS | 12771 | |2;audio-dft;160;161;160;162;160;161;160;166;164;160 02:29:29 INFO - PROCESS | 12771 | |3;audio-fft;72;72;96;99;75;72;73;110;96;76 02:29:29 INFO - PROCESS | 12771 | |4;audio-oscillator;92;93;143;92;93;93;144;92;92;139 02:29:29 INFO - PROCESS | 12771 | |5;imaging-gaussian-blur;117;118;116;117;117;117;118;116;117;117 02:29:29 INFO - PROCESS | 12771 | |6;imaging-darkroom;145;146;145;145;145;146;145;147;145;146 02:29:29 INFO - PROCESS | 12771 | |7;imaging-desaturate;95;96;95;96;96;96;95;95;95;95 02:29:29 INFO - PROCESS | 12771 | |8;json-parse-financial;56;57;57;56;57;57;59;64;55;54 02:29:29 INFO - PROCESS | 12771 | |9;json-stringify-tinderbox;60;60;61;60;60;60;61;65;60;60 02:29:29 INFO - PROCESS | 12771 | |10;stanford-crypto-aes;77;79;78;85;77;78;77;80;79;77 02:29:29 INFO - PROCESS | 12771 | |11;stanford-crypto-ccm;111;107;110;108;113;119;114;108;110;113 02:29:29 INFO - PROCESS | 12771 | |12;stanford-crypto-pbkdf2;142;140;140;140;140;140;141;138;138;139 02:29:29 INFO - PROCESS | 12771 | |13;stanford-crypto-sha256-iterative;64;63;65;63;62;63;64;65;62;62 02:29:29 INFO - PROCESS | 12771 | __end_tp_report 02:29:29 INFO - PROCESS | 12771 | __start_cc_report 02:29:29 INFO - PROCESS | 12771 | _x_x_mozilla_cycle_collect,1067 02:29:29 INFO - PROCESS | 12771 | __end_cc_report 02:29:29 INFO - PROCESS | 12771 | __startTimestamp1458552569947__endTimestamp 02:29:29 INFO - PROCESS | 12771 | 02:29:29 INFO - PROCESS | 12771 | ------- Summary: start ------- 02:29:29 INFO - PROCESS | 12771 | Number of tests: 14 02:29:29 INFO - PROCESS | 12771 | 02:29:29 INFO - PROCESS | 12771 | [#0] ai-astar Cycles:10 Average:108.30 Median:110.00 stddev:3.71 (3.4%) stddev-sans-first:3.81 02:29:29 INFO - PROCESS | 12771 | Values: 111.0 110.0 105.0 110.0 110.0 111.0 99.0 109.0 108.0 110.0 02:29:29 INFO - PROCESS | 12771 | 02:29:29 INFO - PROCESS | 12771 | [#1] audio-beat-detection Cycles:10 Average:147.10 Median:152.50 stddev:20.84 (13.7%) stddev-sans-first:21.85 02:29:29 INFO - PROCESS | 12771 | Values: 156.0 129.0 149.0 174.0 126.0 144.0 160.0 126.0 182.0 125.0 02:29:29 INFO - PROCESS | 12771 | 02:29:29 INFO - PROCESS | 12771 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.00 stddev:2.07 (1.3%) stddev-sans-first:2.13 02:29:29 INFO - PROCESS | 12771 | Values: 160.0 161.0 160.0 162.0 160.0 161.0 160.0 166.0 164.0 160.0 02:29:29 INFO - PROCESS | 12771 | 02:29:29 INFO - PROCESS | 12771 | [#3] audio-fft Cycles:10 Average:84.10 Median:75.50 stddev:14.48 (19.2%) stddev-sans-first:14.68 02:29:29 INFO - PROCESS | 12771 | Values: 72.0 72.0 96.0 99.0 75.0 72.0 73.0 110.0 96.0 76.0 02:29:29 INFO - PROCESS | 12771 | 02:29:29 INFO - PROCESS | 12771 | [#4] audio-oscillator Cycles:10 Average:107.30 Median:92.00 stddev:23.98 (26.1%) stddev-sans-first:24.79 02:29:29 INFO - PROCESS | 12771 | Values: 92.0 93.0 143.0 92.0 93.0 93.0 144.0 92.0 92.0 139.0 02:29:29 INFO - PROCESS | 12771 | 02:29:29 INFO - PROCESS | 12771 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 02:29:29 INFO - PROCESS | 12771 | Values: 117.0 118.0 116.0 117.0 117.0 117.0 118.0 116.0 117.0 117.0 02:29:29 INFO - PROCESS | 12771 | 02:29:29 INFO - PROCESS | 12771 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 02:29:29 INFO - PROCESS | 12771 | Values: 145.0 146.0 145.0 145.0 145.0 146.0 145.0 147.0 145.0 146.0 02:29:29 INFO - PROCESS | 12771 | 02:29:29 INFO - PROCESS | 12771 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 02:29:29 INFO - PROCESS | 12771 | Values: 95.0 96.0 95.0 96.0 96.0 96.0 95.0 95.0 95.0 95.0 02:29:29 INFO - PROCESS | 12771 | 02:29:29 INFO - PROCESS | 12771 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:57.00 stddev:2.74 (4.8%) stddev-sans-first:2.87 02:29:29 INFO - PROCESS | 12771 | Values: 56.0 57.0 57.0 56.0 57.0 57.0 59.0 64.0 55.0 54.0 02:29:29 INFO - PROCESS | 12771 | 02:29:29 INFO - PROCESS | 12771 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:60.00 stddev:1.57 (2.6%) stddev-sans-first:1.64 02:29:29 INFO - PROCESS | 12771 | Values: 60.0 60.0 61.0 60.0 60.0 60.0 61.0 65.0 60.0 60.0 02:29:29 INFO - PROCESS | 12771 | 02:29:29 INFO - PROCESS | 12771 | [#10] stanford-crypto-aes Cycles:10 Average:78.70 Median:78.50 stddev:2.45 (3.1%) stddev-sans-first:2.52 02:29:29 INFO - PROCESS | 12771 | Values: 77.0 79.0 78.0 85.0 77.0 78.0 77.0 80.0 79.0 77.0 02:29:29 INFO - PROCESS | 12771 | 02:29:29 INFO - PROCESS | 12771 | [#11] stanford-crypto-ccm Cycles:10 Average:111.30 Median:112.00 stddev:3.59 (3.2%) stddev-sans-first:3.81 02:29:29 INFO - PROCESS | 12771 | Values: 111.0 107.0 110.0 108.0 113.0 119.0 114.0 108.0 110.0 113.0 02:29:29 INFO - PROCESS | 12771 | 02:29:29 INFO - PROCESS | 12771 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.80 Median:140.00 stddev:1.23 (0.9%) stddev-sans-first:1.01 02:29:29 INFO - PROCESS | 12771 | Values: 142.0 140.0 140.0 140.0 140.0 140.0 141.0 138.0 138.0 139.0 02:29:29 INFO - PROCESS | 12771 | 02:29:29 INFO - PROCESS | 12771 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.30 Median:63.50 stddev:1.16 (1.8%) stddev-sans-first:1.20 02:29:29 INFO - PROCESS | 12771 | Values: 64.0 63.0 65.0 63.0 62.0 63.0 64.0 65.0 62.0 62.0 02:29:29 INFO - PROCESS | 12771 | -------- Summary: end -------- 02:29:29 INFO - PROCESS | 12771 | 02:29:30 INFO - TEST-INFO | 12771: exit 0 02:29:30 INFO - TEST-OK | kraken | took 59530ms 02:29:30 INFO - SUITE-END | took 1170s 02:29:31 INFO - Completed test suite (00:19:30) 02:29:31 INFO - javascript benchmark 02:29:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3007.9849600751995, 3072.4316001539732, 3110.0, 3112.7509799216077, 3133.42031724131, 5242.344706911636, 5305.204219367092, 5312.574994000485, 5340.599455040873, 5377.354717433904, 5226.05930932432, 5246.816361427351, 5253.842384728455, 5272.23552584875, 5386.2997810284705, 4793.712377257376, 4795.424549054118, 4851.175300198975, 4938.135826230396, 4958.181899986498, 4716.316134160545, 4795.184818580849, 4918.5327393897705, 4948.802047918079, 4963.851084467454, 4822.180229361017, 4822.63830212732, 4832.903341933159, 4833.419989601271, 4876.975615121937, 4808.206645903421, 4820.276958456225, 4834.661573689843, 4846.345743324641, 4858.708477491362, 4729.361536192604, 4733.83431579893, 4811.879703007417, 4822.156122678517, 4865.951340486586, 5283.365996080456, 5286.180642000496, 5291.0, 5304.867378315535, 5315.681059136426, 5696.832149409361, 5708.058170401879, 5714.485696287354, 5717.656940583578, 5717.771289148429, 5536.778528858841, 5715.171300161495, 5717.342505611825, 5766.567507436959, 5785.074388097926, 5293.285406470154, 5319.813806516753, 5321.574274058066, 5327.573794096463, 5337.866553336159, 5775.711214439261, 5790.276215473066, 5795.88408231833, 5799.217105690678, 5803.216565763568, 5398.811041613525, 5582.637128586629, 5640.746166422521, 5664.433556644385, 5694.487496125369, 5648.604597678123, 5657.915131273035, 5661.915071273934, 5663.065594176997, 5668.858278542987, 5534.833954981357, 5626.718664066781, 5632.718364081861, 5633.492985631313, 5634.690092044977, 5670.603057785916, 5705.5435565154685, 5719.742611582489, 5733.168690539848, 5769.221155144086, 4313.072689371737, 4325.805338759764, 4330.415393921843, 4335.913281734411, 4375.190589740908, 3785.564660064073, 3807.1814559869763, 3835.4822099016274, 3845.8846234613006, 3860.9961410033034, 5392.164214546751, 5412.78348866041, 5416.0792665247, 5416.431274716098, 5461.290032295776, 5734.827955161351, 5738.713064346766, 5739.770409183586, 5739.7704091836695, 5745.798897038583, 5309.070912590281, 5343.064963631349, 5382.623216374895, 5449.237106805051, 5456.863578410572, 4928.901421971612, 4932.580730637936, 4933.087378834927, 4951.232558953368, 4968.826091086795, 5949.345571987078, 5953.077273022688, 5956.55325850563, 5960.433758792994, 5974.492168165668, 5544.223808666709, 5709.714514274353, 5763.538916886639, 5776.682282474504, 5786.739596718242, 5954.523638109027, 5962.940370596239, 5967.254093238345, 5968.791092311748, 5969.492593129633, 5639.661620302795, 5642.435756424325, 5660.377358490645, 5667.801626943037, 5672.7163641816915, 5603.663780173202, 5684.062129748545, 5727.255456790591, 5761.913571296518, 5784.0, 5605.075162598126, 5608.10270356741, 5618.04493236159, 5620.213170156263, 5628.240187574625, 5427.782888684408, 5530.529904958124, 5574.219609254788, 5575.832725018094, 5587.608867379245, 5473.863153421196, 5502.972485137549, 5504.394516603091, 5515.944840551543, 5547.805826796042, 5530.115181570929, 5558.166275058774, 5559.16612508127, 5585.720713964204, 5586.581006424616, 5356.3572371315695, 5394.163904594794, 5455.099908515051, 5469.070258056219, 5469.425710300361], "unit": "score", "name": "dojo.html", "value": 5249.587301299172}, {"lowerIsBetter": false, "replicates": [527.5753018819848, 538.5314776144754, 553.8310815201362, 558.4527163379889, 570.5806232419171, 30803.691963080364, 39441.80279098604, 39903.810099939525, 39945.80027099864, 39968.80015599918, 42591.14817703644, 42999.71000869971, 43065.56934430655, 43070.0, 43072.0, 8595.183457571537, 8793.208611224989, 8794.208521233088, 8795.604197811113, 8797.472151670889, 8624.52565108922, 8717.912820871774, 8734.86897696535, 8735.95632021839, 8742.737717868475, 8727.996280427737, 9007.819843603156, 9024.503652299121, 9031.503267320295, 9032.638694452215, 8922.464652120894, 8980.416272942302, 8985.820283594358, 8988.415752976036, 9000.594973226187, 8829.205371516595, 8939.061398553189, 8952.328575356874, 8952.686655967074, 8964.14840590143, 42706.0, 43204.0, 43220.0, 43328.0, 43331.0, 3433.8111403872776, 3526.717862571014, 3694.612065733086, 3860.7104467165077, 4143.461350024508, 30439.69560304413, 31056.844715776504, 31136.0, 31610.841945790355, 33066.834665826755, 4215.929062150493, 4297.183535128347, 4328.437303150602, 4328.61042506176, 4375.850569040014, 315962.0, 323189.0, 323590.0, 323628.0, 323699.38150309335, 67161.0, 67267.66366168235, 67305.93287704818, 67687.32312676909, 67750.0, 73093.0, 75091.24908750952, 75092.24907750962, 75099.0, 75116.62441687756, 16969.490915272563, 17212.913935430242, 17215.483535493957, 17215.82784172167, 17216.741748873777, 12299.0, 12369.381530923418, 12397.132200745862, 12402.13185077054, 12404.131710780339, 22338.55322893533, 22565.210217642303, 22576.66135007976, 22612.208572699878, 22625.20811771613, 8564.528950907636, 8913.37606367548, 8934.821303574023, 9038.683646072355, 9091.227245684191, 1014.4369874719602, 1037.1184493180735, 1113.092829344082, 1114.0, 1165.7551914098135, 31562.842185788923, 33471.3305733884, 35353.46969795455, 35603.0, 36324.63675363265, 1082.5128692088592, 1113.6046703420332, 1174.8707642159357, 1175.835383046374, 1243.583399561139, 16301.67396652084, 17283.308667653404, 17403.0, 17445.65108697819, 17541.210645520983, 440620.0, 454627.0, 456334.0, 456492.0, 457083.0, 59104.0, 59468.70265648731, 59529.40470595325, 59549.0, 59583.70208148932, 1325.8872995795273, 1403.7683782176032, 1426.9357878895266, 1457.6793105516558, 1458.0668372241773, 31012.68987310188, 31354.05937821869, 32740.0, 33194.66805332012, 34577.82711086429, 46661.766691166325, 48318.0, 48668.0, 48703.26945095897, 48729.26906096341, 276234.0, 278056.0, 278186.0, 278244.0, 278866.0, 31977.200569985936, 36651.816740916125, 36977.44533832048, 37024.0, 37046.25907481889, 46935.53064469311, 47091.29363059625, 47324.290135648684, 47959.0, 48167.277490838365, 39462.0, 39496.802515988384, 39641.80179099086, 39806.402903957045, 42767.0, 39240.87970763029, 39880.20239595134, 40510.59489405068, 40945.0, 41537.0, 40454.19091618092, 40906.1818763629, 40984.79507602443, 41453.0, 41739.373909391994, 33908.830455847565, 36821.0, 36997.0, 37293.254134916606, 37455.81272093622, 28148.577771333858, 28537.42925141527, 28763.49176292412, 28957.355437931026, 28983.420331593672], "unit": "score", "name": "ext.html", "value": 20267.050178806116}, {"lowerIsBetter": false, "replicates": [354.15309162716443, 359.4464524632066, 359.8794403874702, 362.49613037877344, 366.57660402235393, 17485.388011419604, 18062.638747225046, 19448.902755486237, 19802.207911683516, 19820.108095135718, 17911.64176716465, 18252.908735456338, 19004.14481348339, 19012.714809277837, 19026.14382352794, 5425.3760817506, 5613.2422123013275, 5614.635048721841, 5633.183188437674, 5644.5484361251, 3928.0572662561067, 5512.062949298629, 5800.506956908668, 6033.758649654009, 6053.667048312341, 5992.850178745544, 6004.309504406983, 6016.578839481238, 6017.097435384683, 6021.488173505258, 5901.262342207224, 5929.318128415222, 6017.097435384683, 6036.0644100164545, 6049.183360246377, 3690.5202323698018, 5171.379434467888, 5274.314339135926, 5343.225232341328, 5375.059364611177, 20406.5918681627, 20669.58660826775, 20687.27594534184, 22163.889180553993, 22212.11151553936, 2342.8828558572004, 2364.7635236476385, 2431.039739302983, 2491.7134529528976, 2551.9106831261, 13680.31598420075, 13927.721445571031, 14036.508722194674, 14304.85695143056, 14407.991440599162, 1955.5697746495748, 2042.8467864910192, 2158.4819643285655, 2231.631780756173, 2295.104909085458, 71891.64054179747, 83469.58265208696, 84888.0, 85687.7146842804, 86293.0, 17375.391861284796, 17806.732899006525, 18173.54566135857, 18280.90859545694, 18344.908275458536, 28150.71849281522, 28222.0, 28364.71635283662, 28475.71524284772, 28569.0, 10145.0, 10280.537375818107, 10393.116585090353, 10432.530536125892, 10475.423851688078, 8993.505357205286, 9014.819703605892, 9087.545622718837, 9117.0, 9156.908430915606, 8681.262092722189, 8688.91311086881, 8723.0, 8801.339899507562, 8803.603837827313, 2828.8302701837956, 3163.6712580716153, 3266.2324353776844, 3299.7525185610693, 3363.327334533103, 985.8508451575634, 1009.9040591143829, 1013.3970287678819, 1038.8234000219982, 1056.709404913655, 17964.281428742703, 18190.90904545469, 18221.0, 18633.0, 18875.433736987914, 959.9712008639613, 997.8652881861001, 1010.8584798128268, 1035.435687550287, 1084.7233955341337, 10060.0, 10406.323588966692, 10469.84295235572, 10510.684679459628, 10646.254762166574, 510206.0, 516787.0, 526241.0, 530059.0, 536718.0, 85743.57128214443, 86048.0, 86336.56831715802, 87375.0, 88845.0, 1029.3875144289286, 1034.7102811212872, 1051.1905832508926, 1051.8054159980275, 1060.490964337107, 16409.09749963716, 16454.0, 16460.0, 16468.42360517376, 16510.42213522569, 36938.630613693516, 38021.95824334102, 38958.2208355837, 39330.0, 39492.0, 54762.45237547573, 54786.45213547813, 54841.451585483635, 54851.45148548623, 54918.725406372716, 8175.1007389188335, 8201.22088401601, 8240.381971352053, 8280.917190828255, 8485.660573577235, 10344.431056291976, 12507.249565026128, 12663.493460261487, 12812.10315277959, 13058.542950996669, 11181.608643697431, 11422.657320280405, 11523.308601483937, 11773.411329433322, 11894.643160705193, 11228.606998755004, 11488.94255528717, 11501.827472588086, 11550.537978480766, 11751.059915206592, 9643.84273887138, 10840.295380800539, 11273.7745245093, 11856.525738970344, 11882.108841836724, 7963.362930965393, 8004.199580041949, 8021.8395632088195, 8046.678132874619, 8150.673973041012, 11173.776524469627, 11772.470238839102, 11783.234089784137, 11814.94092529532, 11853.288802671867], "unit": "score", "name": "jquery.html", "value": 9837.148649051496}, {"lowerIsBetter": false, "replicates": [1333.6532501549607, 1471.507045139878, 1475.9409623615056, 1620.2222932992163, 1751.605888675049, 7683.923160768398, 7877.251661092194, 7877.251661092201, 7879.645415956282, 7882.881756773653, 7546.6981320747245, 7726.768196954086, 7728.574928378937, 7735.4585179037485, 7742.341900938427, 2069.0, 2328.7438381777993, 2333.0784340185614, 2357.116081469449, 2376.4534157143867, 2373.5134297468976, 2412.8311018228733, 2412.9034838606435, 2413.070967677439, 2415.0339864054345, 2313.225069601677, 2372.79831214347, 2373.4303767095857, 2373.6320870265135, 2374.4657452073234, 2323.802476789475, 2330.627099664054, 2378.9762102378927, 2379.750126236755, 2383.380321116505, 2325.8720770357622, 2329.5108027314286, 2337.520808234308, 2385.284414675608, 2395.209580838319, 7768.922310776877, 7828.725994590162, 7831.060272767248, 7831.804204894866, 7836.843263134705, 4955.727434991074, 5050.9494905051215, 5060.114479965991, 5068.873278168038, 5070.062038522885, 3387.5088112223834, 3417.179876829568, 3467.809270490122, 3548.1307079765625, 3556.1820781220463, 1069.1500257295468, 1098.3958822647512, 1099.6096385783012, 1110.639042311252, 1162.9185956983015, 10867.29362591437, 11050.557977680883, 11055.391953442557, 11061.778764424667, 11072.224944253825, 4596.931046034245, 4609.377734005933, 4701.177293973541, 4705.55297246761, 4712.175369310357, 9381.202597779265, 9391.01394353583, 9406.482643454676, 9409.388389754644, 9409.576569054409, 4534.79593418297, 5119.3088932994315, 5164.638475306692, 5168.689878607295, 5173.4826517347965, 4513.593776560126, 4529.13946350199, 4538.863834084917, 4552.97723511387, 4628.5371462853445, 3744.1388480649057, 3838.213166300902, 3861.227754449121, 3891.669208117342, 3899.9610003900166, 1244.7137158453424, 1257.1137348169518, 1257.5787111317627, 1263.1663102352586, 1274.7004453953314, 1365.4469939674448, 1370.260059567842, 1370.5819724983776, 1408.141033969278, 1411.3578321863527, 7522.134954480305, 7710.922890771133, 7712.807179820549, 7714.3442807362, 7714.9228507715325, 471.43663322329485, 478.5836322399535, 483.0435737240284, 487.55875932281344, 490.68105731274954, 6018.939810601925, 6021.759129634853, 6038.486728628028, 6076.817695469143, 6077.756889724362, 9058.50178240203, 9615.182709469633, 9642.373245739005, 9745.902540974641, 9781.41311521311, 9539.379940303857, 9580.856287155699, 9628.807423851484, 9630.0, 9637.9036209637, 7357.117145942414, 7559.848803024019, 7569.091708994956, 7639.618019099023, 7643.503172293783, 7286.234945330664, 7327.670254838438, 7343.412526997934, 7344.889826652711, 7412.295831895961, 8459.238668519863, 8725.91274087251, 8739.0, 8786.077461866413, 8891.555422228992, 8684.0, 8783.78714410046, 8808.823823523622, 8865.68970086044, 9276.211522020434, 6791.117154769849, 7278.854422911406, 7435.405167586689, 7686.57723825195, 7801.375889928679, 7529.4729368943645, 7609.847803044019, 7634.770956871303, 7658.655360508679, 7669.3864490841715, 6717.261101278953, 6862.759803407056, 6876.656167191721, 6955.826104347229, 7018.227994920452, 6738.797836064926, 6750.594964302158, 6777.559458635173, 6945.0, 6949.75675851363, 7127.358537731629, 7139.929010648444, 7234.421246300389, 7272.490925635155, 7336.0, 6714.83212919681, 6727.764528241488, 6775.525713200029, 6775.864482710417, 6776.390124888783, 6741.59550426976, 6751.662416879235, 6807.523473356818, 6812.080369150101, 6817.522773405814], "unit": "score", "name": "mootools.html", "value": 4573.386642239278}, {"lowerIsBetter": false, "replicates": [335.85390355195494, 337.9560657114575, 341.8376271271147, 343.8057497513906, 344.0692925636154, 5965.313988891274, 5972.28332600088, 5989.251343582052, 5992.610480318776, 5996.550258730602, 5901.262342207224, 5971.611845230057, 5981.551383646222, 5983.341832398432, 5983.49140323072, 4388.407564978727, 4449.621782148522, 4530.818767249306, 4577.359169716243, 4605.447346318447, 4569.246074397721, 4572.725636461806, 4582.0, 4596.448426188846, 4604.240300350438, 4320.1143765527995, 4534.274516077428, 4539.727616343013, 4540.318952157187, 4542.15970045541, 4428.97785511072, 4509.594136527729, 4531.660125490602, 4554.0, 4570.2687569988975, 3999.0402303446963, 4000.6999475039197, 4019.97990010051, 4021.2158629067344, 4023.1752490739327, 5765.4522820332, 5775.0, 5776.104703770922, 5779.682117483537, 5787.681677507735, 5312.309399778004, 5314.0, 5317.308749862493, 5317.335333083364, 5319.521243088141, 6251.812445626639, 6260.373962603749, 6270.0, 6276.843078923018, 6277.811665650038, 4359.847405340798, 4423.7566933818625, 4450.26570615848, 4453.819737769493, 4456.799444024994, 6514.739410423577, 6522.510811689142, 6540.542162048659, 6541.378569035982, 6542.0, 4539.205639013159, 4546.1135078659345, 4554.294084416921, 4557.680962332605, 4560.475545312265, 4599.33309670096, 4599.67802253839, 4606.447226332794, 4606.608438282784, 4608.677392582487, 5258.237555554423, 5268.236105764643, 5269.1832765921345, 5270.341207349082, 5276.577873770089, 6004.42957918997, 6291.653959032205, 6299.559030867796, 6301.6219026858535, 6317.810465686037, 1566.7414876545242, 1583.3508261612683, 1593.219322531974, 1594.194931559555, 1599.856012958816, 1006.3609607899036, 1015.9034891685278, 1029.6910926721953, 1031.4017869635593, 1046.9267151299337, 6002.069679199731, 6167.259928808572, 6184.103305020837, 6201.720922558496, 6209.627422354673, 6567.704453299613, 6584.045313429526, 6590.7693230736695, 6591.769288074895, 6593.241777195588, 6175.84560385994, 6180.103884936659, 6181.196444462281, 6182.505399568024, 6186.721597528122, 3487.6572519580145, 3524.6122926478065, 3527.488514165483, 3528.594211665691, 3535.416656251741, 6654.733810647616, 6758.459323254128, 6816.897746533707, 6820.624865632339, 6834.316568343126, 6666.96666516674, 6676.599404035774, 6684.398404143553, 6685.832854178587, 6701.6314102723845, 6794.932050679528, 6797.2523022467485, 6808.863822723617, 6812.318768123148, 6814.659267036727, 6552.803415897531, 6553.574017688835, 6558.80323590293, 6558.8360290993105, 6566.080748695091, 6229.626222426669, 6377.266614339224, 6381.649009304533, 6473.417392434703, 6481.287058423664, 6709.563878347892, 6770.187577490733, 6808.523403361915, 6811.795646130624, 6815.727370905108, 4431.578999994996, 4468.285074388083, 4472.575105364985, 4474.351219073281, 4474.395956545824, 6496.285408604956, 6522.315156908457, 6535.705893234911, 6544.345565443417, 6545.901811472927, 6198.442140207403, 6353.555251132377, 6390.360963903572, 6392.712327945161, 6396.968015159894, 6297.4647154992335, 6331.968340158454, 6380.617162970237, 6387.041943708295, 6390.7443702251385, 6232.532560057924, 6245.500359971283, 6257.812265632038, 6262.029385445263, 6264.906026409516, 6420.6147631142285, 6435.774747883802, 6437.967810160919, 6438.323975982455, 6446.065320528403, 5868.94131058684, 5981.521478281814, 6072.392760723892, 6257.0614407837365, 6276.780312689034], "unit": "score", "name": "prototype.html", "value": 4779.142504951428}, {"lowerIsBetter": false, "replicates": [777.9260970207828, 842.6418772021889, 844.9619767110481, 845.4377838737237, 855.3029281135875, 13669.7949530757, 13885.097468664555, 13912.0, 13941.930290348533, 13948.2328471934, 15121.773173402407, 15266.69466610667, 15271.08373497591, 15287.0, 15296.235188240598, 674.2482132422339, 811.882277069826, 821.876718492225, 824.196408501709, 824.3652387661527, 808.7735434078438, 828.693383448125, 829.0217543298905, 829.0590180145548, 829.2246749289403, 863.7451951674271, 867.8611422172454, 868.5049521772593, 868.695956415256, 869.026690107081, 701.4493622506334, 840.7141571865595, 860.9827803443927, 862.7282406042077, 864.6887120636566, 635.0696230023038, 635.2789583822349, 635.3170341882495, 635.3805040085925, 635.4693830651412, 14039.64900877476, 14050.508232211823, 14081.0, 14099.436022559084, 14105.294735263196, 13617.319134043357, 14265.286735663176, 14281.285935703278, 14301.427942882272, 14690.338934747855, 10902.291351062235, 11026.117910567136, 11240.044596209333, 11459.77080458386, 11464.866456109936, 3680.190358121209, 3714.7585406948733, 3731.3470142724914, 3733.439984002421, 3753.3056384568667, 56776.716116419564, 56868.14697779537, 56882.14676779851, 56999.0, 57238.0, 10656.360618362924, 10733.963202386873, 10788.298760580537, 10878.184136189817, 10980.396078215776, 19375.8062419374, 19394.5151371214, 19414.805851941583, 19438.0, 19444.125014374386, 7713.0, 8032.196780321921, 8038.276555110068, 8118.675252989814, 8207.548584827891, 4665.4168228971375, 4830.227163653799, 4841.8547443576745, 4842.806287748521, 4873.610111191097, 3572.499850020999, 3577.928441431157, 3578.7673801202836, 3594.1913069559664, 3598.442241452579, 640.2157357237347, 642.495640921874, 648.3516483516484, 651.1372431528245, 665.0356982375574, 769.5651956644477, 789.7986013566504, 792.426158027301, 810.631162820915, 832.6586099699094, 9568.904310956941, 9619.0, 9734.36726612768, 9756.219502439788, 9817.460039697742, 622.956393052482, 731.8902164675235, 747.8653842308437, 751.4814777803298, 773.2190487607556, 4271.786410679453, 4578.725276483422, 4585.403897493371, 4646.372739680168, 4651.046535460223, 68348.0, 69247.30752692408, 69776.0, 69960.0, 69965.30034699588, 57851.0, 60082.0, 60210.698946504985, 60271.0, 61050.69474652598, 50395.74802125966, 50542.0, 53650.46349536454, 53939.0, 54825.0, 9030.407400606326, 9265.72202833916, 9314.48770317639, 9331.580078896603, 9339.20616747584, 40655.39016914689, 40684.59315406926, 41759.164816704106, 41820.79089604533, 41900.371494426996, 52328.21507677464, 52984.0, 53104.0, 53754.73122634518, 53845.0, 11197.24889180449, 11227.428160057761, 11373.0, 11399.544018239509, 11577.536898523964, 12461.314627695563, 12715.682107947376, 12744.235345879277, 12774.552890648783, 12940.352982350656, 10961.0, 11677.88322116768, 12722.491100355883, 13182.670433238862, 13415.597532074053, 11987.460564274454, 12167.087468440079, 12367.443465044274, 12588.244705317711, 12763.553275635308, 12266.386680665753, 12532.248065116122, 12600.684982875502, 12831.679208019501, 12968.416421260878, 10106.0, 10139.645112421325, 10217.438040907822, 10244.743881403025, 10574.10120139766, 10408.375497470177, 10615.7197386039, 10827.187960902806, 11044.171687123337, 11245.887541124812], "unit": "score", "name": "yui.html", "value": 6912.394156392656}], "name": "dromaeo_css", "value": 7353.723969047369}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 110.0, 105.0, 110.0, 110.0, 111.0, 99.0, 109.0, 108.0, 110.0], "unit": "score", "name": "ai-astar", "value": 108.3}, {"lowerIsBetter": true, "replicates": [156.0, 129.0, 149.0, 174.0, 126.0, 144.0, 160.0, 126.0, 182.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 147.1}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 160.0, 162.0, 160.0, 161.0, 160.0, 166.0, 164.0, 160.0], "unit": "score", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 96.0, 99.0, 75.0, 72.0, 73.0, 110.0, 96.0, 76.0], "unit": "score", "name": "audio-fft", "value": 84.1}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 143.0, 92.0, 93.0, 93.0, 144.0, 92.0, 92.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 107.3}, {"lowerIsBetter": true, "replicates": [117.0, 118.0, 116.0, 117.0, 117.0, 117.0, 118.0, 116.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.0}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 147.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 57.0, 56.0, 57.0, 57.0, 59.0, 64.0, 55.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 57.2}, {"lowerIsBetter": true, "replicates": [60.0, 60.0, 61.0, 60.0, 60.0, 60.0, 61.0, 65.0, 60.0, 60.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 60.7}, {"lowerIsBetter": true, "replicates": [77.0, 79.0, 78.0, 85.0, 77.0, 78.0, 77.0, 80.0, 79.0, 77.0], "unit": "score", "name": "stanford-crypto-aes", "value": 78.7}, {"lowerIsBetter": true, "replicates": [111.0, 107.0, 110.0, 108.0, 113.0, 119.0, 114.0, 108.0, 110.0, 113.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 111.3}, {"lowerIsBetter": true, "replicates": [142.0, 140.0, 140.0, 140.0, 140.0, 140.0, 141.0, 138.0, 138.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 139.8}, {"lowerIsBetter": true, "replicates": [64.0, 63.0, 65.0, 63.0, 62.0, 63.0, 64.0, 65.0, 62.0, 62.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 63.3}], "name": "kraken", "value": 1477.1}]} 02:29:31 INFO - Return code: 0 02:29:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 02:29:31 ERROR - # TBPL SUCCESS # 02:29:31 INFO - Running post-action listener: _resource_record_post_action 02:29:31 INFO - Running post-run listener: _resource_record_post_run 02:29:32 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 143360; Write bytes: 528297984; Read time: 572; Write time: 438800 02:29:32 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 8192; Write bytes: 242376704; Read time: 224; Write time: 267568 02:29:32 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 135168; Write bytes: 285872128; Read time: 348; Write time: 171216 02:29:32 INFO - Running post-run listener: _upload_blobber_files 02:29:32 INFO - Blob upload gear active. 02:29:32 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 02:29:32 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 02:29:32 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'] 02:29:32 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 02:29:32 INFO - (blobuploader) - INFO - Open directory for files ... 02:29:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 02:29:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:29:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:29:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:29:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:29:33 INFO - (blobuploader) - INFO - Done attempting. 02:29:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:29:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:29:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:29:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:29:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:29:34 INFO - (blobuploader) - INFO - Done attempting. 02:29:34 INFO - (blobuploader) - INFO - Iteration through files over. 02:29:34 INFO - Return code: 0 02:29:34 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 02:29:34 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 02:29:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6b316d61ec101b51cd7bb01d7878b53c29a15e00dcbf5b86b80852a9075a2e22594fded3aac5bd2dbe44a4c8d72be55e96671c8d204f9fdf1b4f68ce9e368591", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3278fd5d25766206cae78147aca02826603fa221910807cff3756b02c83757c2c8423cac641de74567c734c6b1daf61d149436e4b525a7dd1e7c819518004297"} 02:29:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 02:29:34 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 02:29:34 INFO - Contents: 02:29:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6b316d61ec101b51cd7bb01d7878b53c29a15e00dcbf5b86b80852a9075a2e22594fded3aac5bd2dbe44a4c8d72be55e96671c8d204f9fdf1b4f68ce9e368591", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3278fd5d25766206cae78147aca02826603fa221910807cff3756b02c83757c2c8423cac641de74567c734c6b1daf61d149436e4b525a7dd1e7c819518004297"} 02:29:34 INFO - Running post-run listener: copy_logs_to_upload_dir 02:29:34 INFO - Copying logs to upload dir... 02:29:34 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 02:29:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.387905 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-03-21 02:29:34.257180) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-21 02:29:34.260736) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1458551342.828594-144312879 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/6b316d61ec101b51cd7bb01d7878b53c29a15e00dcbf5b86b80852a9075a2e22594fded3aac5bd2dbe44a4c8d72be55e96671c8d204f9fdf1b4f68ce9e368591", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3278fd5d25766206cae78147aca02826603fa221910807cff3756b02c83757c2c8423cac641de74567c734c6b1daf61d149436e4b525a7dd1e7c819518004297"} build_url:https://queue.taskcluster.net/v1/task/GxI6FjqiT6-Odrfgs9ELxg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011400 build_url: 'https://queue.taskcluster.net/v1/task/GxI6FjqiT6-Odrfgs9ELxg/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/6b316d61ec101b51cd7bb01d7878b53c29a15e00dcbf5b86b80852a9075a2e22594fded3aac5bd2dbe44a4c8d72be55e96671c8d204f9fdf1b4f68ce9e368591", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3278fd5d25766206cae78147aca02826603fa221910807cff3756b02c83757c2c8423cac641de74567c734c6b1daf61d149436e4b525a7dd1e7c819518004297"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-21 02:29:34.286355) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 02:29:34.286679) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1458551342.828594-144312879 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004505 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 02:29:34.369926) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-21 02:29:34.370278) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-21 02:29:34.370575) ========= ========= Total master_lag: 0.25 =========