builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-034 starttime: 1458735736.36 results: success (0) buildid: 20160323023054 builduid: 35b79ee626624be3bb5a8993f982a983 revision: efe7d026ac641759838dd3897c37892e37e5b244 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-23 05:22:16.361009) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-23 05:22:16.361470) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-23 05:22:16.362210) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1458735733.244411-1535115106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004381 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-23 05:22:16.383255) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-23 05:22:16.383601) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-23 05:22:16.401816) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 05:22:16.402167) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1458735733.244411-1535115106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004551 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 05:22:16.451787) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-23 05:22:16.452111) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-23 05:22:16.452525) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 05:22:16.455886) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1458735733.244411-1535115106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-23 05:22:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 39.6M=0s 2016-03-23 05:22:16 (39.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.156181 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 05:22:16.627898) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 05:22:16.628622) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1458735733.244411-1535115106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018053 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 05:22:16.685066) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 05:22:16.685499) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev efe7d026ac641759838dd3897c37892e37e5b244 --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 efe7d026ac641759838dd3897c37892e37e5b244 --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=d6bbd613908ccac0c6c9cb47000001f7-1458735733.244411-1535115106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-23 05:22:16,773 truncating revision to first 12 chars 2016-03-23 05:22:16,773 Setting DEBUG logging. 2016-03-23 05:22:16,773 attempt 1/10 2016-03-23 05:22:16,773 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/efe7d026ac64?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-23 05:22:17,042 unpacking tar archive at: fx-team-efe7d026ac64/testing/mozharness/ program finished with exit code 0 elapsedTime=0.542352 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 05:22:17.241696) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-23 05:22:17.242096) ========= echo efe7d026ac641759838dd3897c37892e37e5b244 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'efe7d026ac641759838dd3897c37892e37e5b244'] 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=d6bbd613908ccac0c6c9cb47000001f7-1458735733.244411-1535115106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False efe7d026ac641759838dd3897c37892e37e5b244 program finished with exit code 0 elapsedTime=0.004723 script_repo_revision: 'efe7d026ac641759838dd3897c37892e37e5b244' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-23 05:22:17.296351) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-23 05:22:17.297124) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-23 05:22:17.308184) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-03-23 05:22:17.308725) ========= /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=d6bbd613908ccac0c6c9cb47000001f7-1458735733.244411-1535115106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:22:17 INFO - MultiFileLogger online at 20160323 05:22:17 in /builds/slave/test-pgo 05:22:17 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 05:22:17 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:22:17 INFO - {'append_to_log': False, 05:22:17 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:22:17 INFO - 'blob_upload_branch': 'Fx-Team', 05:22:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:22:17 INFO - 'branch': 'Fx-Team', 05:22:17 INFO - 'buildbot_json_path': 'buildprops.json', 05:22:17 INFO - 'config_files': ('talos/linux_config.py',), 05:22:17 INFO - 'default_actions': ('clobber', 05:22:17 INFO - 'read-buildbot-config', 05:22:17 INFO - 'download-and-extract', 05:22:17 INFO - 'populate-webroot', 05:22:17 INFO - 'create-virtualenv', 05:22:17 INFO - 'install', 05:22:17 INFO - 'run-tests'), 05:22:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:22:17 INFO - 'download_minidump_stackwalk': True, 05:22:17 INFO - 'download_symbols': 'ondemand', 05:22:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:22:17 INFO - 'tooltool.py': '/tools/tooltool.py', 05:22:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:22:17 INFO - '/tools/misc-python/virtualenv.py')}, 05:22:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:22:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:22:17 INFO - 'installer_path': 'installer.exe', 05:22:17 INFO - 'log_level': 'info', 05:22:17 INFO - 'log_name': 'talos', 05:22:17 INFO - 'log_to_console': True, 05:22:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:22:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:22:17 INFO - 'opt_config_files': (), 05:22:17 INFO - 'pip_index': False, 05:22:17 INFO - 'sps_profile': False, 05:22:17 INFO - 'sps_profile_interval': 0, 05:22:17 INFO - 'suite': 'dromaeojs', 05:22:17 INFO - 'system_bits': '32', 05:22:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:22:17 INFO - 'title': 'talos-linux64-ix-034', 05:22:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:22:17 INFO - 'use_talos_json': True, 05:22:17 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:22:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:22:17 INFO - 'work_dir': 'build'} 05:22:17 INFO - ##### 05:22:17 INFO - ##### Running clobber step. 05:22:17 INFO - ##### 05:22:17 INFO - Running pre-action listener: _resource_record_pre_action 05:22:17 INFO - Running main action method: clobber 05:22:17 INFO - rmtree: /builds/slave/test-pgo/build 05:22:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:22:17 INFO - Running post-action listener: _resource_record_post_action 05:22:17 INFO - ##### 05:22:17 INFO - ##### Running read-buildbot-config step. 05:22:17 INFO - ##### 05:22:17 INFO - Running pre-action listener: _resource_record_pre_action 05:22:17 INFO - Running main action method: read_buildbot_config 05:22:17 INFO - Using buildbot properties: 05:22:17 INFO - { 05:22:17 INFO - "project": "", 05:22:17 INFO - "product": "firefox", 05:22:17 INFO - "script_repo_revision": "production", 05:22:17 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:22:17 INFO - "repository": "", 05:22:17 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 05:22:17 INFO - "buildid": "20160323023054", 05:22:17 INFO - "pgo_build": "True", 05:22:17 INFO - "basedir": "/builds/slave/test-pgo", 05:22:17 INFO - "buildnumber": 1025, 05:22:17 INFO - "slavename": "talos-linux64-ix-034", 05:22:17 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:22:17 INFO - "platform": "ubuntu64_hw", 05:22:17 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:22:17 INFO - "branch": "fx-team", 05:22:17 INFO - "repo_path": "integration/fx-team", 05:22:17 INFO - "revision": "efe7d026ac641759838dd3897c37892e37e5b244", 05:22:17 INFO - "stage_platform": "linux64-pgo", 05:22:17 INFO - "builduid": "35b79ee626624be3bb5a8993f982a983", 05:22:17 INFO - "slavebuilddir": "test" 05:22:17 INFO - } 05:22:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/dMIKjra5StylsDvFzb_NDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 05:22:17 INFO - Running post-action listener: _resource_record_post_action 05:22:17 INFO - ##### 05:22:17 INFO - ##### Running download-and-extract step. 05:22:17 INFO - ##### 05:22:17 INFO - Running pre-action listener: _resource_record_pre_action 05:22:17 INFO - Running main action method: download_and_extract 05:22:17 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:22:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:17 INFO - https://queue.taskcluster.net/v1/task/dMIKjra5StylsDvFzb_NDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:22:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dMIKjra5StylsDvFzb_NDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:22:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dMIKjra5StylsDvFzb_NDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:22:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dMIKjra5StylsDvFzb_NDA/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 05:22:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dMIKjra5StylsDvFzb_NDA/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 05:22:18 INFO - Downloaded 1361 bytes. 05:22:18 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:22:18 INFO - Using the following test package requirements: 05:22:18 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:22:18 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:22:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:22:18 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:22:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:22:18 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:22:18 INFO - u'jsshell-linux-x86_64.zip'], 05:22:18 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:22:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:22:18 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:22:18 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:22:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:22:18 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:22:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:22:18 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:22:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:22:18 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:22:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:22:18 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:22:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:18 INFO - https://queue.taskcluster.net/v1/task/dMIKjra5StylsDvFzb_NDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:22:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dMIKjra5StylsDvFzb_NDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:22:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dMIKjra5StylsDvFzb_NDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:22:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dMIKjra5StylsDvFzb_NDA/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 05:22:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dMIKjra5StylsDvFzb_NDA/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 05:22:19 INFO - Downloaded 23607711 bytes. 05:22:19 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'] 05:22:19 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 05:22:20 INFO - Return code: 0 05:22:20 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 05:22: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')]} 05:22:20 INFO - https://queue.taskcluster.net/v1/task/dMIKjra5StylsDvFzb_NDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:22:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dMIKjra5StylsDvFzb_NDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:22:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dMIKjra5StylsDvFzb_NDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:22:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dMIKjra5StylsDvFzb_NDA/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 05:22:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dMIKjra5StylsDvFzb_NDA/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 05:22:22 INFO - Downloaded 23607711 bytes. 05:22:22 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'] 05:22:22 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 05:22:23 INFO - Return code: 0 05:22: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')]} 05:22:23 INFO - https://queue.taskcluster.net/v1/task/dMIKjra5StylsDvFzb_NDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:22:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dMIKjra5StylsDvFzb_NDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:22:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dMIKjra5StylsDvFzb_NDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:22:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dMIKjra5StylsDvFzb_NDA/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 05:22:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dMIKjra5StylsDvFzb_NDA/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 05:22:24 INFO - Downloaded 10848120 bytes. 05:22:24 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'] 05:22:24 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 05:22:24 INFO - Return code: 0 05:22:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:24 INFO - https://queue.taskcluster.net/v1/task/dMIKjra5StylsDvFzb_NDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:22:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dMIKjra5StylsDvFzb_NDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:22:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dMIKjra5StylsDvFzb_NDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:22:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dMIKjra5StylsDvFzb_NDA/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 05:22:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dMIKjra5StylsDvFzb_NDA/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 05:22:26 INFO - Downloaded 57741888 bytes. 05:22:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dMIKjra5StylsDvFzb_NDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:22:26 INFO - mkdir: /builds/slave/test-pgo/properties 05:22:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:22:26 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:22:26 INFO - Contents: 05:22:26 INFO - build_url:https://queue.taskcluster.net/v1/task/dMIKjra5StylsDvFzb_NDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:22:26 INFO - Running post-action listener: _resource_record_post_action 05:22:26 INFO - Running post-action listener: set_extra_try_arguments 05:22:26 INFO - ##### 05:22:26 INFO - ##### Running populate-webroot step. 05:22:26 INFO - ##### 05:22:26 INFO - Running pre-action listener: _resource_record_pre_action 05:22:26 INFO - Running main action method: populate_webroot 05:22:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:22:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:22:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:22:26 INFO - '--tppagecycles', 05:22:26 INFO - '7'], 05:22:26 INFO - 'tests': ['tsvgm']}}, 05:22:26 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:22:26 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:22:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:22:26 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:22:26 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:22:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:22:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:22:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:26 INFO - 'talos_options': ['--e10s'], 05:22:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:22:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:26 INFO - 'tests': ['damp', 'tps']}, 05:22:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:26 INFO - 'talos_options': ['--e10s'], 05:22:26 INFO - 'tests': ['damp', 'tps']}, 05:22:26 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:22:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:22:26 INFO - 'other': {'tests': ['a11yr', 05:22:26 INFO - 'ts_paint', 05:22:26 INFO - 'tpaint', 05:22:26 INFO - 'sessionrestore', 05:22:26 INFO - 'sessionrestore_no_auto_restore', 05:22:26 INFO - 'tabpaint']}, 05:22:26 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:22:26 INFO - 'tests': ['a11yr', 05:22:26 INFO - 'ts_paint', 05:22:26 INFO - 'tpaint', 05:22:26 INFO - 'sessionrestore', 05:22:26 INFO - 'sessionrestore_no_auto_restore', 05:22:26 INFO - 'tabpaint']}, 05:22:26 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:22:26 INFO - 'tests': ['a11yr', 05:22:26 INFO - 'ts_paint', 05:22:26 INFO - 'tpaint', 05:22:26 INFO - 'sessionrestore', 05:22:26 INFO - 'sessionrestore_no_auto_restore', 05:22:26 INFO - 'tabpaint']}, 05:22:26 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:22:26 INFO - 'tests': ['a11yr', 05:22:26 INFO - 'ts_paint', 05:22:26 INFO - 'tpaint', 05:22:26 INFO - 'sessionrestore', 05:22:26 INFO - 'sessionrestore_no_auto_restore', 05:22:26 INFO - 'tabpaint']}, 05:22:26 INFO - 'other_l64': {'tests': ['a11yr', 05:22:26 INFO - 'ts_paint', 05:22:26 INFO - 'tpaint', 05:22:26 INFO - 'sessionrestore', 05:22:26 INFO - 'sessionrestore_no_auto_restore', 05:22:26 INFO - 'tabpaint']}, 05:22:26 INFO - 'other_nol64': {'tests': ['a11yr', 05:22:26 INFO - 'ts_paint', 05:22:26 INFO - 'tpaint', 05:22:26 INFO - 'sessionrestore', 05:22:26 INFO - 'sessionrestore_no_auto_restore', 05:22:26 INFO - 'tabpaint']}, 05:22:26 INFO - 'svgr': {'tests': ['tsvgx', 05:22:26 INFO - 'tsvgr_opacity', 05:22:26 INFO - 'tart', 05:22:26 INFO - 'tscrollx', 05:22:26 INFO - 'cart']}, 05:22:26 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:22:26 INFO - 'tests': ['tsvgx', 05:22:26 INFO - 'tsvgr_opacity', 05:22:26 INFO - 'tart', 05:22:26 INFO - 'tscrollx', 05:22:26 INFO - 'cart']}, 05:22:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:26 INFO - 'tests': ['tp5o']}, 05:22:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:26 INFO - 'talos_options': ['--e10s'], 05:22:26 INFO - 'tests': ['tp5o']}, 05:22:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:26 INFO - 'talos_options': ['--xperf_path', 05:22:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:22:26 INFO - 'tests': ['tp5n']}, 05:22:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:26 INFO - 'talos_options': ['--e10s', 05:22:26 INFO - '--xperf_path', 05:22:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:22:26 INFO - 'tests': ['tp5n']}}, 05:22:26 INFO - 'talos.zip': {'path': '', 05:22:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:22:26 INFO - Running post-action listener: _resource_record_post_action 05:22:26 INFO - ##### 05:22:26 INFO - ##### Running create-virtualenv step. 05:22:26 INFO - ##### 05:22:26 INFO - Running pre-action listener: _resource_record_pre_action 05:22:26 INFO - Running main action method: create_virtualenv 05:22:26 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:22:26 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 05:22:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:22:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:22:27 INFO - Using real prefix '/usr' 05:22:27 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:22:27 INFO - Installing distribute.............................................................................................................................................................................................done. 05:22:29 INFO - Installing pip.................done. 05:22:29 INFO - Return code: 0 05:22:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:22: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')]} 05:22:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22: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')]} 05:22:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:29 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 0x7f3657cdef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b06b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ab1d0>, '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 0x26ae750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26aebe0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1458735733.244411-1535115106', '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 05:22:29 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 05:22:29 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 05:22:29 INFO - Using env: {'DISPLAY': ':0', 05:22:29 INFO - 'HOME': '/home/cltbld', 05:22:29 INFO - 'LANG': 'en_US.UTF-8', 05:22:29 INFO - 'LANGUAGE': 'en_US:en', 05:22:29 INFO - 'LOGNAME': 'cltbld', 05:22:29 INFO - 'MAIL': '/var/mail/cltbld', 05:22:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:29 INFO - 'MOZ_NO_REMOTE': '1', 05:22:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:22:29 INFO - 'NO_EM_RESTART': '1', 05:22:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:22:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:22:29 INFO - 'PWD': '/builds/slave/test-pgo', 05:22:29 INFO - 'SHELL': '/bin/bash', 05:22:29 INFO - 'SHLVL': '1', 05:22:29 INFO - 'TERM': 'linux', 05:22:29 INFO - 'TMOUT': '86400', 05:22:29 INFO - 'USER': 'cltbld', 05:22:29 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1458735733.244411-1535115106', 05:22:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:29 INFO - '_': '/tools/buildbot/bin/python'} 05:22:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:29 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 05:22:29 INFO - Cleaning up... 05:22:29 INFO - Return code: 0 05:22:29 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:22: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')]} 05:22:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22: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')]} 05:22:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:29 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 0x7f3657cdef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b06b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ab1d0>, '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 0x26ae750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26aebe0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1458735733.244411-1535115106', '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 05:22:29 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 05:22:29 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 05:22:29 INFO - Using env: {'DISPLAY': ':0', 05:22:29 INFO - 'HOME': '/home/cltbld', 05:22:29 INFO - 'LANG': 'en_US.UTF-8', 05:22:29 INFO - 'LANGUAGE': 'en_US:en', 05:22:29 INFO - 'LOGNAME': 'cltbld', 05:22:29 INFO - 'MAIL': '/var/mail/cltbld', 05:22:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:29 INFO - 'MOZ_NO_REMOTE': '1', 05:22:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:22:29 INFO - 'NO_EM_RESTART': '1', 05:22:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:22:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:22:29 INFO - 'PWD': '/builds/slave/test-pgo', 05:22:29 INFO - 'SHELL': '/bin/bash', 05:22:29 INFO - 'SHLVL': '1', 05:22:29 INFO - 'TERM': 'linux', 05:22:29 INFO - 'TMOUT': '86400', 05:22:29 INFO - 'USER': 'cltbld', 05:22:29 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1458735733.244411-1535115106', 05:22:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:29 INFO - '_': '/tools/buildbot/bin/python'} 05:22:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:30 INFO - Downloading/unpacking psutil>=0.7.1 05:22:30 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 05:22:30 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 05:22:30 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 05:22:30 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 05:22:30 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 05:22:30 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 05:22:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:22:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:22:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:22:32 INFO - Installing collected packages: psutil 05:22:32 INFO - Running setup.py install for psutil 05:22:32 INFO - building 'psutil._psutil_linux' extension 05:22:32 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 05:22:32 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 05:22:32 INFO - building 'psutil._psutil_posix' extension 05:22:32 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 05:22:32 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 05:22:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:22:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:22:32 INFO - Successfully installed psutil 05:22:32 INFO - Cleaning up... 05:22:32 INFO - Return code: 0 05:22:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:22: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')]} 05:22:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22: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')]} 05:22:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:32 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3657cdef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b06b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ab1d0>, '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 0x26ae750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26aebe0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1458735733.244411-1535115106', '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 05:22:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 05:22:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:22:32 INFO - Using env: {'DISPLAY': ':0', 05:22:32 INFO - 'HOME': '/home/cltbld', 05:22:32 INFO - 'LANG': 'en_US.UTF-8', 05:22:32 INFO - 'LANGUAGE': 'en_US:en', 05:22:32 INFO - 'LOGNAME': 'cltbld', 05:22:32 INFO - 'MAIL': '/var/mail/cltbld', 05:22:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:32 INFO - 'MOZ_NO_REMOTE': '1', 05:22:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:22:32 INFO - 'NO_EM_RESTART': '1', 05:22:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:22:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:22:32 INFO - 'PWD': '/builds/slave/test-pgo', 05:22:32 INFO - 'SHELL': '/bin/bash', 05:22:32 INFO - 'SHLVL': '1', 05:22:32 INFO - 'TERM': 'linux', 05:22:32 INFO - 'TMOUT': '86400', 05:22:32 INFO - 'USER': 'cltbld', 05:22:32 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1458735733.244411-1535115106', 05:22:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:32 INFO - '_': '/tools/buildbot/bin/python'} 05:22:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:32 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:22:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:34 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:22:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:22:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:22:34 INFO - Installing collected packages: mozsystemmonitor 05:22:34 INFO - Running setup.py install for mozsystemmonitor 05:22:34 INFO - Successfully installed mozsystemmonitor 05:22:34 INFO - Cleaning up... 05:22:35 INFO - Return code: 0 05:22:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:22:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:35 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3657cdef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b06b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ab1d0>, '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 0x26ae750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26aebe0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1458735733.244411-1535115106', '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 05:22:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 05:22:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:22:35 INFO - Using env: {'DISPLAY': ':0', 05:22:35 INFO - 'HOME': '/home/cltbld', 05:22:35 INFO - 'LANG': 'en_US.UTF-8', 05:22:35 INFO - 'LANGUAGE': 'en_US:en', 05:22:35 INFO - 'LOGNAME': 'cltbld', 05:22:35 INFO - 'MAIL': '/var/mail/cltbld', 05:22:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:35 INFO - 'MOZ_NO_REMOTE': '1', 05:22:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:22:35 INFO - 'NO_EM_RESTART': '1', 05:22:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:22:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:22:35 INFO - 'PWD': '/builds/slave/test-pgo', 05:22:35 INFO - 'SHELL': '/bin/bash', 05:22:35 INFO - 'SHLVL': '1', 05:22:35 INFO - 'TERM': 'linux', 05:22:35 INFO - 'TMOUT': '86400', 05:22:35 INFO - 'USER': 'cltbld', 05:22:35 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1458735733.244411-1535115106', 05:22:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:35 INFO - '_': '/tools/buildbot/bin/python'} 05:22:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:35 INFO - Downloading/unpacking blobuploader==1.2.4 05:22:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:37 INFO - Downloading blobuploader-1.2.4.tar.gz 05:22:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:22:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:22: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 05:22: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 05:22: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 05:22: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 05:22: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 05:22: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 05:22:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:22:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:22: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 05:22: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 05:22: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 05:22: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 05:22: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 05:22: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 05:22:38 INFO - Downloading docopt-0.6.1.tar.gz 05:22:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:22:38 INFO - Installing collected packages: blobuploader, requests, docopt 05:22:38 INFO - Running setup.py install for blobuploader 05:22:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:22:38 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:22:38 INFO - Running setup.py install for requests 05:22:38 INFO - Running setup.py install for docopt 05:22:38 INFO - Successfully installed blobuploader requests docopt 05:22:38 INFO - Cleaning up... 05:22:38 INFO - Return code: 0 05:22:38 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:22:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:38 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 0x7f3657cdef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b06b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ab1d0>, '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 0x26ae750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26aebe0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1458735733.244411-1535115106', '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 05:22:38 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 05:22:38 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 05:22:38 INFO - Using env: {'DISPLAY': ':0', 05:22:38 INFO - 'HOME': '/home/cltbld', 05:22:38 INFO - 'LANG': 'en_US.UTF-8', 05:22:38 INFO - 'LANGUAGE': 'en_US:en', 05:22:38 INFO - 'LOGNAME': 'cltbld', 05:22:38 INFO - 'MAIL': '/var/mail/cltbld', 05:22:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:38 INFO - 'MOZ_NO_REMOTE': '1', 05:22:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:22:38 INFO - 'NO_EM_RESTART': '1', 05:22:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:22:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:22:38 INFO - 'PWD': '/builds/slave/test-pgo', 05:22:38 INFO - 'SHELL': '/bin/bash', 05:22:38 INFO - 'SHLVL': '1', 05:22:38 INFO - 'TERM': 'linux', 05:22:38 INFO - 'TMOUT': '86400', 05:22:38 INFO - 'USER': 'cltbld', 05:22:38 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1458735733.244411-1535115106', 05:22:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:38 INFO - '_': '/tools/buildbot/bin/python'} 05:22:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:22:38 INFO - Running setup.py (path:/tmp/pip-fuVEeR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:22:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:22:39 INFO - Running setup.py (path:/tmp/pip-NaG6on-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:22:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:22:39 INFO - Running setup.py (path:/tmp/pip-Vsb3R6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:22:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:22:39 INFO - Running setup.py (path:/tmp/pip-anXVm3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:22:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:22:39 INFO - Running setup.py (path:/tmp/pip-kJEMLD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:22:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:22:39 INFO - Running setup.py (path:/tmp/pip-hrtLzu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:22:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:22:39 INFO - Running setup.py (path:/tmp/pip-4GnHXS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:22:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:22:39 INFO - Running setup.py (path:/tmp/pip-KuUKT3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:22:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:22:39 INFO - Running setup.py (path:/tmp/pip-DNDDxf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:22:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:22:39 INFO - Running setup.py (path:/tmp/pip-87quK2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:22:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:22:39 INFO - Running setup.py (path:/tmp/pip-GBVyxk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:22:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:22:39 INFO - Running setup.py (path:/tmp/pip-pH0E1D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:22:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:22:39 INFO - Running setup.py (path:/tmp/pip-tGQsZj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:22:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:22:39 INFO - Running setup.py (path:/tmp/pip-nrIPJ4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:22:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:22:39 INFO - Running setup.py (path:/tmp/pip-xlEl4U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:22:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:22:39 INFO - Running setup.py (path:/tmp/pip-ejJYbQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:22:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:22:40 INFO - Running setup.py (path:/tmp/pip-V0QyBi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:22:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:22:40 INFO - Running setup.py install for manifestparser 05:22:40 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:22:40 INFO - Running setup.py install for mozcrash 05:22:40 INFO - Running setup.py install for mozdebug 05:22:40 INFO - Running setup.py install for mozdevice 05:22:40 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:22:40 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:22:40 INFO - Running setup.py install for mozfile 05:22:40 INFO - Running setup.py install for mozhttpd 05:22:40 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:22:40 INFO - Running setup.py install for mozinfo 05:22:40 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:22:40 INFO - Running setup.py install for mozInstall 05:22:40 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:22:40 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:22:40 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:22:40 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:22:40 INFO - Running setup.py install for mozleak 05:22:41 INFO - Running setup.py install for mozlog 05:22:41 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:22:41 INFO - Running setup.py install for moznetwork 05:22:41 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:22:41 INFO - Running setup.py install for mozprocess 05:22:41 INFO - Running setup.py install for mozprofile 05:22:41 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:22:41 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:22:41 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:22:41 INFO - Running setup.py install for mozrunner 05:22:41 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:22:41 INFO - Running setup.py install for mozscreenshot 05:22:41 INFO - Running setup.py install for moztest 05:22:41 INFO - Running setup.py install for mozversion 05:22:41 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:22:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:22:41 INFO - Cleaning up... 05:22:41 INFO - Return code: 0 05:22:41 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:22:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:41 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 0x7f3657cdef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b06b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ab1d0>, '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 0x26ae750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26aebe0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1458735733.244411-1535115106', '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 05:22:41 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 05:22:41 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 05:22:41 INFO - Using env: {'DISPLAY': ':0', 05:22:41 INFO - 'HOME': '/home/cltbld', 05:22:41 INFO - 'LANG': 'en_US.UTF-8', 05:22:41 INFO - 'LANGUAGE': 'en_US:en', 05:22:41 INFO - 'LOGNAME': 'cltbld', 05:22:41 INFO - 'MAIL': '/var/mail/cltbld', 05:22:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:41 INFO - 'MOZ_NO_REMOTE': '1', 05:22:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:22:41 INFO - 'NO_EM_RESTART': '1', 05:22:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:22:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:22:41 INFO - 'PWD': '/builds/slave/test-pgo', 05:22:41 INFO - 'SHELL': '/bin/bash', 05:22:41 INFO - 'SHLVL': '1', 05:22:41 INFO - 'TERM': 'linux', 05:22:41 INFO - 'TMOUT': '86400', 05:22:41 INFO - 'USER': 'cltbld', 05:22:41 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1458735733.244411-1535115106', 05:22:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:41 INFO - '_': '/tools/buildbot/bin/python'} 05:22:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:22:42 INFO - Running setup.py (path:/tmp/pip-KKmBXw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:22:42 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)) 05:22:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:22:42 INFO - Running setup.py (path:/tmp/pip-NoQ7Ne-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:22:42 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)) 05:22:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:22:42 INFO - Running setup.py (path:/tmp/pip-WTGNwc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:22:42 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)) 05:22:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:22:42 INFO - Running setup.py (path:/tmp/pip-Dbx0zW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:22:42 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)) 05:22:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:22:42 INFO - Running setup.py (path:/tmp/pip-nJfOba-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:22:42 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)) 05:22:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:22:42 INFO - Running setup.py (path:/tmp/pip-aPaHau-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:22:42 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)) 05:22:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:22:42 INFO - Running setup.py (path:/tmp/pip-zX0Nz4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:22:42 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)) 05:22:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:22:42 INFO - Running setup.py (path:/tmp/pip-XdS3CN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:22:42 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)) 05:22:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:22:42 INFO - Running setup.py (path:/tmp/pip-LZwMRh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:22:42 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)) 05:22:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:22:42 INFO - Running setup.py (path:/tmp/pip-vRv0qZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:22:42 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)) 05:22:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:22:42 INFO - Running setup.py (path:/tmp/pip-PKwmtK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:22:42 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)) 05:22:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:22:42 INFO - Running setup.py (path:/tmp/pip-z1dW9T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:22:43 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)) 05:22:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:22:43 INFO - Running setup.py (path:/tmp/pip-_775__-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:22:43 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)) 05:22:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:22:43 INFO - Running setup.py (path:/tmp/pip-T33pg6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:22:43 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)) 05:22:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:22:43 INFO - Running setup.py (path:/tmp/pip-oHLAaX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:22:43 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)) 05:22:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:22:43 INFO - Running setup.py (path:/tmp/pip-qCNgZH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:22:43 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)) 05:22:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:22:43 INFO - Running setup.py (path:/tmp/pip-Bj6SLe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:22:43 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)) 05:22:43 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)) 05:22:43 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)) 05:22:43 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)) 05:22:43 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)) 05:22:43 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)) 05:22:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:22:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:45 INFO - Downloading blessings-1.6.tar.gz 05:22:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:22:45 INFO - Installing collected packages: blessings 05:22:45 INFO - Running setup.py install for blessings 05:22:45 INFO - Successfully installed blessings 05:22:45 INFO - Cleaning up... 05:22:45 INFO - Return code: 0 05:22:45 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:22:45 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:22:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:22:45 INFO - Reading from file tmpfile_stdout 05:22:45 INFO - Current package versions: 05:22:45 INFO - argparse == 1.2.1 05:22:45 INFO - blessings == 1.6 05:22:45 INFO - blobuploader == 1.2.4 05:22:45 INFO - docopt == 0.6.1 05:22:45 INFO - manifestparser == 1.1 05:22:45 INFO - mozInstall == 1.12 05:22:45 INFO - mozcrash == 0.17 05:22:45 INFO - mozdebug == 0.1 05:22:45 INFO - mozdevice == 0.48 05:22:45 INFO - mozfile == 1.2 05:22:45 INFO - mozhttpd == 0.7 05:22:45 INFO - mozinfo == 0.9 05:22:45 INFO - mozleak == 0.1 05:22:45 INFO - mozlog == 3.1 05:22:45 INFO - moznetwork == 0.27 05:22:45 INFO - mozprocess == 0.22 05:22:45 INFO - mozprofile == 0.28 05:22:45 INFO - mozrunner == 6.11 05:22:45 INFO - mozscreenshot == 0.1 05:22:45 INFO - mozsystemmonitor == 0.0 05:22:45 INFO - moztest == 0.7 05:22:45 INFO - mozversion == 1.4 05:22:45 INFO - psutil == 3.1.1 05:22:45 INFO - requests == 1.2.3 05:22:45 INFO - wsgiref == 0.1.2 05:22:45 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:45 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 0x7f3657cdef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b06b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ab1d0>, '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 0x26ae750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26aebe0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1458735733.244411-1535115106', '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 05:22:45 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 05:22:45 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 05:22:45 INFO - Using env: {'DISPLAY': ':0', 05:22:45 INFO - 'HOME': '/home/cltbld', 05:22:45 INFO - 'LANG': 'en_US.UTF-8', 05:22:45 INFO - 'LANGUAGE': 'en_US:en', 05:22:45 INFO - 'LOGNAME': 'cltbld', 05:22:45 INFO - 'MAIL': '/var/mail/cltbld', 05:22:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:45 INFO - 'MOZ_NO_REMOTE': '1', 05:22:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:22:45 INFO - 'NO_EM_RESTART': '1', 05:22:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:22:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:22:45 INFO - 'PWD': '/builds/slave/test-pgo', 05:22:45 INFO - 'SHELL': '/bin/bash', 05:22:45 INFO - 'SHLVL': '1', 05:22:45 INFO - 'TERM': 'linux', 05:22:45 INFO - 'TMOUT': '86400', 05:22:45 INFO - 'USER': 'cltbld', 05:22:45 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1458735733.244411-1535115106', 05:22:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:45 INFO - '_': '/tools/buildbot/bin/python'} 05:22:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:45 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)) 05:22:45 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)) 05:22:45 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)) 05:22:45 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)) 05:22:45 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)) 05:22:45 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)) 05:22:45 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)) 05:22:45 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)) 05:22:45 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)) 05:22:45 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)) 05:22:45 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)) 05:22:45 INFO - Cleaning up... 05:22:45 INFO - Return code: 0 05:22:45 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:45 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 0x7f3657cdef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b06b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ab1d0>, '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 0x26ae750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26aebe0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1458735733.244411-1535115106', '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 05:22:45 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 05:22:45 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 05:22:45 INFO - Using env: {'DISPLAY': ':0', 05:22:45 INFO - 'HOME': '/home/cltbld', 05:22:45 INFO - 'LANG': 'en_US.UTF-8', 05:22:45 INFO - 'LANGUAGE': 'en_US:en', 05:22:45 INFO - 'LOGNAME': 'cltbld', 05:22:45 INFO - 'MAIL': '/var/mail/cltbld', 05:22:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:45 INFO - 'MOZ_NO_REMOTE': '1', 05:22:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:22:45 INFO - 'NO_EM_RESTART': '1', 05:22:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:22:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:22:45 INFO - 'PWD': '/builds/slave/test-pgo', 05:22:45 INFO - 'SHELL': '/bin/bash', 05:22:45 INFO - 'SHLVL': '1', 05:22:45 INFO - 'TERM': 'linux', 05:22:45 INFO - 'TMOUT': '86400', 05:22:45 INFO - 'USER': 'cltbld', 05:22:45 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1458735733.244411-1535115106', 05:22:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:45 INFO - '_': '/tools/buildbot/bin/python'} 05:22:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:46 INFO - Downloading/unpacking jsonschema 05:22:46 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 05:22:46 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 05:22:46 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 05:22:46 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 05:22:46 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 05:22:46 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 05:22:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:22:47 INFO - Downloading/unpacking functools32 (from jsonschema) 05:22:47 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 05:22:47 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 05:22:47 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 05:22:47 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 05:22:47 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 05:22:47 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 05:22:48 INFO - Downloading functools32-3.2.3-2.tar.gz 05:22:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:22:48 INFO - warning: no files found matching '*.txt' 05:22:48 INFO - no previously-included directories found matching 'build' 05:22:48 INFO - no previously-included directories found matching 'dist' 05:22:48 INFO - no previously-included directories found matching '.git*' 05:22:48 INFO - Installing collected packages: jsonschema, functools32 05:22:48 INFO - Running setup.py install for functools32 05:22:48 INFO - warning: no files found matching '*.txt' 05:22:48 INFO - no previously-included directories found matching 'build' 05:22:48 INFO - no previously-included directories found matching 'dist' 05:22:48 INFO - no previously-included directories found matching '.git*' 05:22:48 INFO - Successfully installed jsonschema functools32 05:22:48 INFO - Cleaning up... 05:22:48 INFO - Return code: 0 05:22:48 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:22:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:48 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 0x7f3657cdef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b06b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ab1d0>, '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 0x26ae750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26aebe0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1458735733.244411-1535115106', '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 05:22:48 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 05:22:48 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 05:22:48 INFO - Using env: {'DISPLAY': ':0', 05:22:48 INFO - 'HOME': '/home/cltbld', 05:22:48 INFO - 'LANG': 'en_US.UTF-8', 05:22:48 INFO - 'LANGUAGE': 'en_US:en', 05:22:48 INFO - 'LOGNAME': 'cltbld', 05:22:48 INFO - 'MAIL': '/var/mail/cltbld', 05:22:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:48 INFO - 'MOZ_NO_REMOTE': '1', 05:22:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:22:48 INFO - 'NO_EM_RESTART': '1', 05:22:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:22:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:22:48 INFO - 'PWD': '/builds/slave/test-pgo', 05:22:48 INFO - 'SHELL': '/bin/bash', 05:22:48 INFO - 'SHLVL': '1', 05:22:48 INFO - 'TERM': 'linux', 05:22:48 INFO - 'TMOUT': '86400', 05:22:48 INFO - 'USER': 'cltbld', 05:22:48 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1458735733.244411-1535115106', 05:22:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:48 INFO - '_': '/tools/buildbot/bin/python'} 05:22:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:48 INFO - Downloading/unpacking flake8 05:22:48 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 05:22:48 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 05:22:48 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 05:22:48 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 05:22:48 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 05:22:48 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 05:22:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:22:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:22:50 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 05:22:50 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 05:22:50 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 05:22:50 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 05:22:50 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 05:22:50 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 05:22:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:22:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:22:50 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 05:22:50 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 05:22:50 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 05:22:50 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 05:22:50 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 05:22:50 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 05:22:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:22:50 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 05:22:50 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 05:22:50 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 05:22:50 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 05:22:50 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 05:22:50 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 05:22:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:22:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:22:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:22:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:22:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:22:51 INFO - no previously-included directories found matching 'docs/_build' 05:22:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:22:51 INFO - Running setup.py install for pep8 05:22:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:22:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:22:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:22:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:22:51 INFO - no previously-included directories found matching 'docs/_build' 05:22:51 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:22:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:22:51 INFO - Cleaning up... 05:22:51 INFO - Return code: 0 05:22:51 INFO - Running post-action listener: _resource_record_post_action 05:22:51 INFO - Running post-action listener: _start_resource_monitoring 05:22:51 INFO - Starting resource monitoring. 05:22:51 INFO - ##### 05:22:51 INFO - ##### Running install step. 05:22:51 INFO - ##### 05:22:51 INFO - Running pre-action listener: _resource_record_pre_action 05:22:51 INFO - Running main action method: install 05:22:51 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:22:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:22:51 INFO - Reading from file tmpfile_stdout 05:22:51 INFO - Detecting whether we're running mozinstall >=1.0... 05:22:51 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:22:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:22:51 INFO - Reading from file tmpfile_stdout 05:22:51 INFO - Output received: 05:22:51 INFO - Usage: mozinstall [options] installer 05:22:51 INFO - Options: 05:22:51 INFO - -h, --help show this help message and exit 05:22:51 INFO - -d DEST, --destination=DEST 05:22:51 INFO - Directory to install application into. [default: 05:22:51 INFO - "/builds/slave/test-pgo"] 05:22:51 INFO - --app=APP Application being installed. [default: firefox] 05:22:51 INFO - mkdir: /builds/slave/test-pgo/build/application 05:22:51 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'] 05:22:51 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 05:23:08 INFO - Reading from file tmpfile_stdout 05:23:08 INFO - Output received: 05:23:08 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:23:08 INFO - Running post-action listener: _resource_record_post_action 05:23:08 INFO - ##### 05:23:08 INFO - ##### Running run-tests step. 05:23:08 INFO - ##### 05:23:08 INFO - Running pre-action listener: _resource_record_pre_action 05:23:08 INFO - Running main action method: run_tests 05:23:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:23:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:23:08 INFO - Python 2.7.3 05:23:08 INFO - Return code: 0 05:23:08 INFO - grabbing minidump binary from tooltool 05:23:08 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')]} 05:23:08 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 0x26ab1d0>, '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 0x26ae750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26aebe0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:23:08 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 05:23:08 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 05:23:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:23:08 INFO - Return code: 0 05:23:08 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:23:08 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:23:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:23:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:23:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:23:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:23:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:23:09 INFO - Return code: 0 05:23:09 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/dMIKjra5StylsDvFzb_NDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 05:23:09 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/dMIKjra5StylsDvFzb_NDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --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 05:23:09 INFO - Using env: {'DISPLAY': ':0', 05:23:09 INFO - 'HOME': '/home/cltbld', 05:23:09 INFO - 'LANG': 'en_US.UTF-8', 05:23:09 INFO - 'LANGUAGE': 'en_US:en', 05:23:09 INFO - 'LOGNAME': 'cltbld', 05:23:09 INFO - 'MAIL': '/var/mail/cltbld', 05:23:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:23:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:23:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:09 INFO - 'MOZ_NO_REMOTE': '1', 05:23:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:23:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:09 INFO - 'NO_EM_RESTART': '1', 05:23:09 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:23:09 INFO - 'PWD': '/builds/slave/test-pgo', 05:23:09 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:23:09 INFO - 'SHELL': '/bin/bash', 05:23:09 INFO - 'SHLVL': '1', 05:23:09 INFO - 'TERM': 'linux', 05:23:09 INFO - 'TMOUT': '86400', 05:23:09 INFO - 'USER': 'cltbld', 05:23:09 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1458735733.244411-1535115106', 05:23:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:09 INFO - '_': '/tools/buildbot/bin/python'} 05:23:09 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/dMIKjra5StylsDvFzb_NDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 05:23:09 INFO - mozversion application_buildid: 20160323023054 05:23:09 INFO - mozversion application_changeset: efe7d026ac641759838dd3897c37892e37e5b244 05:23:09 INFO - mozversion application_display_name: Nightly 05:23:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:23:09 INFO - mozversion application_name: Firefox 05:23:09 INFO - mozversion application_remotingname: firefox 05:23:09 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:23:09 INFO - mozversion application_vendor: Mozilla 05:23:09 INFO - mozversion application_version: 48.0a1 05:23:09 INFO - mozversion platform_buildid: 20160323023054 05:23:09 INFO - mozversion platform_changeset: efe7d026ac641759838dd3897c37892e37e5b244 05:23:09 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:23:09 INFO - mozversion platform_version: 48.0a1 05:23:09 INFO - using testdate: 1458735789 05:23:09 INFO - actual date: 1458735789 05:23:09 INFO - starting webserver on 'localhost:57500' 05:23:09 INFO - SUITE-START | Running 2 tests 05:23:09 INFO - TEST-START | dromaeo_css 05:23:09 INFO - operating with platform_type : linux_ 05:23:09 INFO - Initialising browser for dromaeo_css test... 05:23:09 INFO - TEST-INFO | started process 7565 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxX3EP2/profile http://localhost:57500/getInfo.html) 05:23:13 INFO - PROCESS | 7565 | __metrics Screen width/height:1600/1200 05:23:13 INFO - PROCESS | 7565 | colorDepth:24 05:23:13 INFO - PROCESS | 7565 | Browser inner width/height: 1024/697 05:23:13 INFO - PROCESS | 7565 | __metrics 05:23:14 ERROR - PROCESS | 7565 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:23:15 INFO - TEST-INFO | 7565: exit 0 05:23:15 INFO - Browser initialized. 05:23:15 INFO - Running cycle 1/1 for dromaeo_css test... 05:23:15 INFO - TEST-INFO | started process 7661 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxX3EP2/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:23:27 INFO - PROCESS | 7661 | RSS: Main: 155938816 05:23:27 INFO - PROCESS | 7661 | 05:24:19 INFO - PROCESS | 7661 | 1458735859063 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] 05:26:25 INFO - PROCESS | 7661 | Cycle 1(1): loaded http://localhost:57500/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57500/tests/dromaeo/cssquery-ext.html) 05:26:26 INFO - PROCESS | 7661 | RSS: Main: 266653696 05:26:26 INFO - PROCESS | 7661 | 05:29:28 INFO - PROCESS | 7661 | Cycle 1(1): loaded http://localhost:57500/tests/dromaeo/cssquery-ext.html (next: http://localhost:57500/tests/dromaeo/cssquery-jquery.html) 05:29:29 INFO - PROCESS | 7661 | RSS: Main: 244232192 05:29:29 INFO - PROCESS | 7661 | 05:32:31 INFO - PROCESS | 7661 | Cycle 1(1): loaded http://localhost:57500/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57500/tests/dromaeo/cssquery-mootools.html) 05:32:31 INFO - PROCESS | 7661 | RSS: Main: 242569216 05:32:31 INFO - PROCESS | 7661 | 05:35:33 INFO - PROCESS | 7661 | Cycle 1(1): loaded http://localhost:57500/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57500/tests/dromaeo/cssquery-prototype.html) 05:35:34 INFO - PROCESS | 7661 | RSS: Main: 221401088 05:35:34 INFO - PROCESS | 7661 | 05:38:36 INFO - PROCESS | 7661 | Cycle 1(1): loaded http://localhost:57500/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57500/tests/dromaeo/cssquery-yui.html) 05:38:37 INFO - PROCESS | 7661 | RSS: Main: 218451968 05:38:37 INFO - PROCESS | 7661 | 05:41:39 INFO - PROCESS | 7661 | Cycle 1(1): loaded http://localhost:57500/tests/dromaeo/cssquery-yui.html (next: http://localhost:57500/tests/dromaeo/cssquery-dojo.html) 05:41:39 INFO - PROCESS | 7661 | RSS: Main: 270540800 05:41:39 INFO - PROCESS | 7661 | 05:41:39 INFO - PROCESS | 7661 | __start_tp_report 05:41:39 INFO - PROCESS | 7661 | _x_x_mozilla_page_load 05:41:39 INFO - PROCESS | 7661 | _x_x_mozilla_page_load_details 05:41:39 INFO - PROCESS | 7661 | |i|pagename|runs| 05:41:39 INFO - PROCESS | 7661 | |0;dojo.html;2998.7001299870017;3063.1423201503585;3104.4722397192477;3109.4869346557807;3134.937301253974;5186.247994040871;5262.81580144695;5288.788448462066;5314.787408503656;5327.866803329919;5296.973515132419;5321.122014867552;5327;5425.674459532421;5438.91841622376;4695.9530404696025;4725.598324142444;4921.4094308682825;4945.455999840015;4990.550850423461;4696.295555666643;4918.434380046287;4934;4940.431850337203;4956.033573453178;4707.31743897133;4737.90524189516;4760.952390476085;4779.90440191196;4805.279208118775;4812.446568644581;4822.541858523435;4823.710577365334;4835.951640483585;4847.684900481458;4636.374089497908;4778.139934811733;4821.927671084936;4841.709497430165;4887.975560122212;5169.198774190007;5193.350831146106;5194.27280180775;5200.6619569727845;5211.817586384458;5598.936202121584;5607.243022192033;5609.831705048855;5610.074337734269;5648.74580643872;5492.340919089695;5607;5663.207150998864;5767.913481297784;5768.538516918637;5270.578353731692;5307.230451584537;5357.973210133963;5362.705051222181;5383.811566595189;5852.15143804146;5871.089981052944;5877.647341159544;5880;5885.529157667376;5412.5940554458575;5491.807786727445;5578.581606379537;5608.158776183605;5635.605507614428;5630.8029218977135;5636.802711905064;5640.153976903497;5640.182173584889;5647.209390685307;5437.918431223535;5557.916206339806;5560.277163968739;5561.360443548962;5565.2486914266865;5563.443655634485;5614.382417934024;5627.155926610959;5642.520385767174;5676.687782171937;4258.7657678827345;4261.147770445861;4271.8718438446895;4297.763623000703;4298.634616057608;3747.7189210809297;3781.262653782486;3810.1236715555024;3828.8277027533827;3850.0182453474185;5405.567554595623;5419.945800541944;5425.267588875451;5442.2380866678695;5473.808416705476;5725.312962444534;5740.799072032459;5758.280214973129;5761.971190144022;5763.221965034667;5220.556252718561;5359.517643412111;5422.430644782241;5424.186372044225;5445.233174588909;4869.659123861366;4882.511748825089;4882.6826256293225;4906.533879281463;4923.581495572845;5854.268216472941;5858.355580886099;5858.589898707135;5861.531077513789;5863.384344643751;5524.309461317335;5670.74481648335;5696.686682232517;5770.6249093808765;5779.595428320145;5848.561357898089;5850.678212698343;5854.092615644582;5857.4435428634215;5863.912041319299;5570.303712035996;5570.470805273492;5572.721363931868;5577.051901176728;5585.441455854382;5598.468145526169;5655.038643430545;5709.8287051388525;5713.485786279255;5756.30924289088;5553.389127196086;5561.388247292875;5565.833025009256;5578.470045345685;5584.916226256691;5307.867303317448;5528.799365171252;5528.91706624409;5536.335639723259;5538.47384498472;5502.394736578893;5551.084071128219;5570.053090974463;5582.441755824548;5611.551075913835;5576.749046292845;5578.525825304894;5592.077307244422;5596.832095037155;5607.579431542569;5355.196720491957;5488;5504.697241651747;5530.861728456821;5557.749901254534 05:41:39 INFO - PROCESS | 7661 | |1;ext.html;558.2009426315047;568.8350378390267;576.4091805898954;597.7310210405317;599.6132494541024;37272;37648.43527347092;37650.43524347134;37661;37718.811405942935;41154;41375.58624413755;41672.79163604185;41743.16513669725;41899.581004189946;8344.332453403713;8658.696945606873;8669.913300866974;8673.913260867404;8677.522736249504;8573.442726222807;8709.25971292441;8726.254749050184;8729.388942774009;8733.825323493526;8858.645654173826;9006.86489702655;9007.909920900773;9013.774655633597;9016.819663606724;8859.601317940707;8879.067697891693;8941.374103812735;8945.507997060158;8951.73144805657;8749.737507874774;9008.28842519919;9012.819743605156;9014.459132452073;9022.7293181204;40839.183216335805;41126.177476450306;41174;41181;41193;3439.8108104054268;3717.033571271462;3833.846646134179;4038.7778672173017;4355.651547876162;31354.05937821869;31979.52030719541;32186;32251.83874080638;33015.17462063444;4226.725262857935;4244.490661120685;4247.439671563105;4330.39374487572;4375.628071613916;296522;299547;300681.9999999978;300916;301362;53379.46620533745;60209;61347;61416.69291653513;61450.07824882631;50069;50675;50693.23960140601;50762;50762.74618626957;16164;16241.187940602922;16345.673086538203;16398.09810460436;16413.6717265654;11065.668029959113;12277.263364198177;12400.75198496043;12401.62795116148;12451.066170037102;19406;19635.496202253627;20292.08685609151;20300.79699202989;20408.285710000375;7551.395888328921;7597.164311925684;7603.315701586773;7604.885926711104;7648.235176482419;1008.9041541053588;1014.1937159957852;1043.1446214104362;1105.4086063955745;1153.8269259611125;28231.71768282332;28463.57304640432;29871.103866884027;29872.850635746683;30522.847385763373;1109.4175557832202;1122.887711228887;1125.8648962124598;1205.9035277177804;1289.9935500322438;15520.183901640343;16068.598285042734;16162.272697728631;16180.67638647244;16186.433474828324;372693;372786;373720;375022;378203;47182;47396.7630161847;47423.28865067027;47486.287705684445;47525.52474475211;1235.5922545560124;1282.602393258093;1393.7560926837764;1394.8884089272833;1417.8723914847712;29657;31152;32267.35465290728;32559.837200813843;33181.17047073843;39148.6085139145;39485.80257098696;39509;39515.604843951194;39709.80145099371;239588;240588;241318;242066;242572;27945;36219.27561448809;48969;49096.263556045975;49907.50092499029;39624;40371;52022;52049.739751301;52702.73648631732;38775.2244955105;38848;41817.1636567273;41858.790706046275;43666.56333436625;40759.59240407558;41061.38407923824;41528.37707434451;41890.58109418867;42506.78746606247;42901.78549107235;43446.56553434425;44121.55878441175;44611.33083003823;44707.32939005983;37454.438183426726;38522;38716.225675485766;38854.222915542094;38929.80535097307;29244.70755292505;29258.414831703674;29625.85187074051;29629.111126666234;30199.396012080077 05:41:39 INFO - PROCESS | 7661 | |2;jquery.html;361.7540072750529;377.67897287305794;377.8601917290602;381.6507895275823;387.56214444411233;17755.289788408463;18127.27490900364;18770.155343009563;19093.713594296096;19133.42599722007;16797.83202167978;16976;17748.733768993443;17757.64484710305;17790.911045444755;5597.244372009777;5733.283339582552;5747.109198074305;5760.164776107462;5761;4014.5784692607294;5768.653880767147;6119.112728654342;6401.327860574643;6422.743090276384;6349.111124442582;6361.809145725636;6368.777092801753;6392.872142557146;6396.392342727457;6059.909101363483;6250.5312101592335;6328.1773369462135;6329.050642403653;6340.080688300193;3657.2502636959625;5260.079486089957;5428.45715428458;5483.451654834525;5493.505584497414;20156.193752249892;20634.17463301466;20771;21063.47341316464;21103.15587376503;2302.7121609798774;2648.8278261913106;3109.347037122207;3112.1597168764306;3139.4035133324824;13173.802392964113;13374.531891383755;13475.86524134756;13721.519746808814;14027.298635068206;1923.913423895928;2048.3957232616413;2069.503319203395;2099.349201747463;2142.882141482218;65632.67183664051;65957;66001;68321.65839170772;69400.30599693989;10654.147668186526;10707.785844283071;10967.945160274148;11035.337879727242;11144.944275278573;14375.78436323456;14377.424903003763;14463.204523751085;14475.855241447662;14479.85520144785;8054.275115239657;8272.669093236203;8282;8372.748817535483;8387.580620968927;7869.993151746268;7879.803004924923;7954.482958607672;7971.481853679492;8061.4760040597175;6691.431228345547;6792.694328755218;6809.270931559899;6818.261343357412;6829.351211634887;1727.1623262717571;1824.9908750456163;1861.2275905499337;1861.3485280151838;1900.2304066852946;945.635930166877;996.6611352140308;1057.9735506612242;1075.5751478166237;1080.0927221134127;18279;18349.99075050885;18401.723974140397;19037.90481047586;19308.4207473776;1036.7252678040325;1045.1482042135635;1050.5115121468555;1067.5516283161091;1126.7014241226082;10409.583616655249;10759.569617215224;10810.837837432446;10961.177911656658;11206.887931120747;451869;452376;453461;454682;471037;51243;62831.05753413703;83543;84008.57995710104;84391.15608843956;1101.0805977009286;1115.570505355444;1121.43928035982;1175.5591653130077;1177;16359;16442.588935276715;16449.424270150488;16714.080725559725;16831.158442078093;36773.26453470862;37353.439698404;38122.809385952896;38136.61863381442;38595.614043859205;53518;53624.19563706625;53695.46304536905;53910.730446347516;54318.45681543292;7865.528068315919;8071.83856322882;8079.272865442138;8127.593620318842;8247.835043299221;12332.19840710351;12449;12727.490900364252;12868.549600763929;13130.606081817561;8284;10367.32612380193;10940.179486538382;11227.326360418401;11476.770464590829;10598.31110977784;10672.679819605424;10922.18083643714;11103.555857765921;11501.367424791382;11257.268277561932;11328.94335528317;11405;11443.771124577628;11627.244229125079;7969.442139050443;7973.083095443866;7996.120426753168;8188.713395031145;8217.917820821714;10221.795564088825;11515.769684606094;11624.88375116238;11644.941775291069;11725.941370293094 05:41:39 INFO - PROCESS | 7661 | |3;mootools.html;1402.389960367241;1495.8653721165092;1502.9549113526596;1670.1899578704326;1803.5220666523373;7345.963270183648;7519.586422746746;7563.205863384348;7565.243475652445;7570.621468926553;7325;7493.063367079115;7493.1008279006455;7494.288042635954;7496.250374962501;1893.1764682363148;2282.224043825099;2321.895514701834;2322.3613506285824;2344.941376465585;2331.265651319837;2342.285602891126;2352.1061996441326;2353.9411514712097;2353.9882300588474;2280.623697089978;2347.80043696286;2365.9826274701873;2368.0409434179187;2370.4547953970596;2290.977090229093;2301.2981040782556;2302.5394921015695;2303.4126297794037;2349.3304408243653;2213.5683541709373;2213.756486786452;2217.8669279843098;2246.067881829039;2287.3824067501846;7715.382769378436;7763.107242667109;7764.689412423496;7767.18444563324;7769.922300776976;4936.358273424467;5086.059079070347;5087.49125087492;5089.821856235051;5093.0577843099145;3138.7959782614057;3231.8060916345094;3248.7238584720326;3315.5855518060243;3321.186309354224;1045.4772613693153;1053.1522124689623;1053.510117795229;1093.3330668292335;1104.8895110488968;10457.111145552637;10725.83911241332;10732.087772539266;10736.30214036085;10985.505652245669;4207.894802629959;4265.55211702773;4298.032942587893;4302.053548219386;4343.543927887589;8591.957040214758;8595;8597.097304783032;8603.139686031347;8604.741857744277;4336.6313863321975;4946.777395017233;4954.752262386866;4956.752162391938;4958.479359667183;4525.615322697542;4609.562091601292;4642.303654451859;4650.837220697259;4668.0197158597075;3624.4382120771324;3686.299603075407;3704.851496036237;3722.16251343451;3724.5344331958504;1093;1115.4199816095586;1130.2935665209245;1131.2703306367348;1149.3793351590048;1038.8753349597946;1057.281048886749;1059.8304271316551;1110.9888901110885;1181.5214837990627;7647.808804779925;7704.26809453101;7729.4202934779;7748.186440423674;7753.1859154787935;456.6324109092146;458.2175337935434;459.4096585887119;460.26357827476437;466.55677106748726;5529.557635389159;5531.308586426697;5557.861053473695;5579;5580.776768929279;9435.292353073546;9616.423014619146;9866.901330986742;9867.259955503367;9883.505824708736;9640.614375424904;9685.32202745801;9769.951150244346;9813.264005199639;9827.901720982698;7349.63251837406;7398.297161769623;7494.362979146725;7518.511296765692;7581.166071732105;7410.11078670563;7427.071616047994;7445.181030086578;7454.962725186339;7470.103587569526;8555.82888342242;8590.012148602991;8719.869201961848;8725.171108744658;8904.777380565538;8759.299256059627;8847.867281990904;8864.06927272627;9016.954915225644;9031.096890311179;5867.178594996789;5953.404659534012;5975.462208401264;6676.9332306676315;6773.93226067733;7339;7478.2521747824785;7483.476156668981;7514.9624251878395;7545.50954187976;6683.264840867598;6875.518713689994;6885.139357580302;6953.443724502129;7036.19083805369;6695.799126026227;6716.126903502709;6759.222689390783;6786.524943253925;6993.405560527209;7194.604296763729;7213.314735100157;7239.239879812544;7248.275172482709;7317.963410182915;6662.666866656745;6678.098456708476;6709.027191057172;6711.328867113445;6715.328467153246;6634.502412318999;6683.264840867598;6684.665766711742;6715.093462382516;6722.697478613572 05:41:39 INFO - PROCESS | 7661 | |4;prototype.html;331.08455121588804;331.5987654937525;336.6952907618606;336.73398015567693;336.98652053917846;5825.796097136601;5849.385814489481;5852.561057920651;5855;5868.677222752747;5812.767489300433;5815.854603634912;5816.098504731774;5820.068788993762;5840.153177789218;4247.872563823083;4346.043870348518;4369.235383807837;4459.687821852472;4477.865664030068;4443.289073748201;4475.910481790363;4483.574060464267;4488.496353721507;4489.2817149256125;4432.468103827545;4433.2685106957315;4434.17967675981;4438.977805110986;4443.111377724452;4249.405083288342;4337.1976184405985;4423;4438.489573699034;4444.133393988173;3921.4117882317883;3927.3127202739406;3927.586069015152;3928.194720082376;3940.9211815763524;5590.944090559124;5609.971950140264;5626.508975121596;5629.324481062258;5633.718314084321;5203.375594928595;5204.0372531081875;5207.531322181022;5210.557102646279;5210.76551555181;6125.356837532084;6129.233845769279;6131.816045518642;6138.294096178952;6141.938580614182;4152.8131234094535;4267.487901451815;4268.679849011337;4383.276759334706;4388.166248412791;6413.807585772434;6460.709268082947;6475.7085931133215;6479.287278399373;6490.675466226669;4328.632066274339;4334.544872788375;4336;4339.566043395698;4351.4995775485595;4405.31717583775;4406.801693923781;4408.228560001987;4409.3606427068535;4416.757078360657;5088.72012039334;5097.311862898536;5100.872478188075;5102.36220472441;5103.209002604603;6007.549433792483;6237;6240.375962403723;6251.687415629201;6252.218472690914;1536.9769453458207;1546.5901536092945;1547.411983446283;1550.3720992997853;1550.999605254627;959.3236768078488;1032.4321623107262;1033.2767063055892;1042.2027149230844;1059.4120263253967;5920.526357891358;5928.525717942554;5928.881422371528;5929.762809487572;5930.762769489258;6310.495160387158;6329.145565348711;6329.398707122816;6330.082138090043;6331.050342448578;5964.761409543657;5973.940260597426;5974.850628734316;5975.342712301644;5979.312379076375;3374.122728090665;3401.4387626041425;3410.1645096951406;3412.8805491807666;3415.7608967372043;6400.839979000562;6531.640759758164;6553.475721942328;6558.508111891627;6563.474922006228;6435.388638079468;6439.774607888701;6451.387118223761;6479.157709497829;6479.7408103675325;6501.739930402826;6512.869742605027;6517.4134327910715;6518.967405162944;6521.836954076186;6305.4009869062365;6360.9045864313;6364.64994425311;6364.713587888464;6366.299707032315;6042.123892035718;6205.782797602063;6210.099535567227;6214.2853571838;6222.906656400067;6448.709808058742;6499.805005849643;6504.414602685781;6512.674366281762;6517.967410162919;4376.12477504494;4385.890352741207;4390.209762242827;4394.362817391524;4406.184855801687;6278.963970944743;6282.1519094921605;6290.433860952537;6291.716872740646;6294.748210071546;6113.84715382119;6131.080337949344;6134.171886795404;6134.263888333428;6144.754209831557;6002.849928751816;6083.482903953037;6254.781082662085;6261.7182226799;6265.028920517327;6134.38656134383;6159.6612186330185;6159.9836027055035;6160.753569857335;6162.938370616236;6253.6560489173535;6272.09054687077;6278.8430289241305;6283.685815709287;6289.905651415141;5841.795537156179;5947.613405128653;6083.574149809471;6118.632882027093;6130.47890929276 05:41:39 INFO - PROCESS | 7661 | |5;yui.html;839.5969934431471;851.4593233296855;857.8976015819673;859.4757198109153;859.9269062129719;13381.063325567202;13780.035397522164;13781.58655240343;13804.861951380482;13814.585562433118;13683;13722.794158087636;13726.656833579165;13738.725225495484;13762;633.4109278371113;797.0833541427347;807.6284908941893;809.3282575462352;822.411975437562;781.8358144789601;792.0416296281506;793.4326956226297;793.6507936507946;801.7835184500182;850.8213275212213;852.2883392367349;852.8251708399794;855.2046596665099;869.7695110795644;672.6872004517899;830.5141492227024;862.7282406042077;867.020267098175;868.8696695495663;629.6725702634604;629.7953165221321;630.095812509051;630.533405280094;630.6184758221256;13086.214827110403;13166.934165329112;13298.468061277537;13335.599932002055;13386.598402047954;13123.54067607629;13607.931960340235;13626.110986630876;13854.16874987504;13924.51264205758;11447.484863181176;11464;11563;11694.649160525198;11724.296542207494;3768.7550309229814;3814.275287695329;3836.9616303836883;3927.528696556403;3946.921061578781;54414.45585544134;54546.454535454934;54789.452105478835;54979.45020549784;55183.44816551823;10125.139363154067;10487.26589138753;10717;10762.78474430507;10910.399928003877;18239.088045597666;18410.079496025144;19288.614227715367;19339.709904351446;19348.70976935347;8276.875846862302;8278.793030174294;8344.374171937008;8482.575871206538;8607.48355098696;4678.087772884255;4725.315608025965;4792.7124372537755;4797.95202047982;4828.734419606885;3271.5583396241204;3285.227971426713;3290.8848190313224;3301.1417031571964;3321.2029113013186;586.9325027621878;599.66718471248;607.8389226854887;610.9053096770008;621.1676353686082;616.6176970278456;698.979030629082;742.2985278911485;747.5178509861217;753.1677496366545;9633.518324083769;9750.414975101517;9750.707478775648;9755.661679292241;9758.463284519277;622.8847663182326;683.9452843772486;704.281632734618;746.4998451037818;755.316438623047;4425.269830477935;4798.736069516141;4806.831760888352;4806.927896081562;4823.975880120577;60930.39069609247;60963;61492.38507614867;65248.67375663092;66047;56559.71720141373;57162.42837571654;57273.42726572681;57402.425975740545;58505.12242316369;52186.73906630443;52348;52712;52799.208011879855;53029;9792.657256995972;9812.65655702047;9865.210783137476;9941.502924853872;9944.254180936314;37259.81370093132;37391;37757.62242377651;38008.23983520369;38142.42786358151;45922.54077459183;46006.53993460022;47057.76471117623;51811.222831658306;52125.21812172745;11535.769284614093;11935.82096268574;11985.22096063753;12180.512779488721;12365.38173091324;11614;12274;12529.812052819032;13270.867291326964;13679.863201368256;12301.890180936518;12357.75284494323;12613.369331533204;12881.8067728986;13464.663383415493;12632.431540580512;12659.367031648564;12664.430100645677;12738.490460381852;13163.868361316265;12197.085218608463;12768.106232563632;12898.161619494704;12906.290154041242;13391.799123012968;10424;10630.946845265724;10774.414140606355;11046.944765276123;11249;10652.680419587425;11028.669139925814;11280;11295.435228238719;11297.943510282395 05:41:39 INFO - PROCESS | 7661 | __end_tp_report 05:41:39 INFO - PROCESS | 7661 | __start_cc_report 05:41:39 INFO - PROCESS | 7661 | _x_x_mozilla_cycle_collect,792 05:41:39 INFO - PROCESS | 7661 | __end_cc_report 05:41:39 INFO - PROCESS | 7661 | __startTimestamp1458736899877__endTimestamp 05:41:39 INFO - PROCESS | 7661 | 05:41:39 INFO - PROCESS | 7661 | ------- Summary: start ------- 05:41:39 INFO - PROCESS | 7661 | Number of tests: 6 05:41:39 INFO - PROCESS | 7661 | 05:41:39 INFO - PROCESS | 7661 | [#0] dojo.html Cycles:165 Average:5265.56 Median:5502.39 stddev:604.83 (11.0%) stddev-sans-first:579.95 05:41:39 INFO - PROCESS | 7661 | Values: 2998.7 3063.1 3104.5 3109.5 3134.9 5186.2 5262.8 5288.8 5314.8 5327.9 5297.0 5321.1 5327.0 5425.7 5438.9 4696.0 4725.6 4921.4 4945.5 4990.6 4696.3 4918.4 4934.0 4940.4 4956.0 4707.3 4737.9 4761.0 4779.9 4805.3 4812.4 4822.5 4823.7 4836.0 4847.7 4636.4 4778.1 4821.9 4841.7 4888.0 5169.2 5193.4 5194.3 5200.7 5211.8 5598.9 5607.2 5609.8 5610.1 5648.7 5492.3 5607.0 5663.2 5767.9 5768.5 5270.6 5307.2 5358.0 5362.7 5383.8 5852.2 5871.1 5877.6 5880.0 5885.5 5412.6 5491.8 5578.6 5608.2 5635.6 5630.8 5636.8 5640.2 5640.2 5647.2 5437.9 5557.9 5560.3 5561.4 5565.2 5563.4 5614.4 5627.2 5642.5 5676.7 4258.8 4261.1 4271.9 4297.8 4298.6 3747.7 3781.3 3810.1 3828.8 3850.0 5405.6 5419.9 5425.3 5442.2 5473.8 5725.3 5740.8 5758.3 5762.0 5763.2 5220.6 5359.5 5422.4 5424.2 5445.2 4869.7 4882.5 4882.7 4906.5 4923.6 5854.3 5858.4 5858.6 5861.5 5863.4 5524.3 5670.7 5696.7 5770.6 5779.6 5848.6 5850.7 5854.1 5857.4 5863.9 5570.3 5570.5 5572.7 5577.1 5585.4 5598.5 5655.0 5709.8 5713.5 5756.3 5553.4 5561.4 5565.8 5578.5 5584.9 5307.9 5528.8 5528.9 5536.3 5538.5 5502.4 5551.1 5570.1 5582.4 5611.6 5576.7 5578.5 5592.1 5596.8 5607.6 5355.2 5488.0 5504.7 5530.9 5557.7 05:41:39 INFO - PROCESS | 7661 | 05:41:39 INFO - PROCESS | 7661 | [#1] ext.html Cycles:180 Average:48306.52 Median:39569.80 stddev:81087.49 (204.9%) stddev-sans-first:81235.71 05:41:39 INFO - PROCESS | 7661 | Values: 558.2 568.8 576.4 597.7 599.6 37272.0 37648.4 37650.4 37661.0 37718.8 41154.0 41375.6 41672.8 41743.2 41899.6 8344.3 8658.7 8669.9 8673.9 8677.5 8573.4 8709.3 8726.3 8729.4 8733.8 8858.6 9006.9 9007.9 9013.8 9016.8 8859.6 8879.1 8941.4 8945.5 8951.7 8749.7 9008.3 9012.8 9014.5 9022.7 40839.2 41126.2 41174.0 41181.0 41193.0 3439.8 3717.0 3833.8 4038.8 4355.7 31354.1 31979.5 32186.0 32251.8 33015.2 4226.7 4244.5 4247.4 4330.4 4375.6 296522.0 299547.0 300682.0 300916.0 301362.0 53379.5 60209.0 61347.0 61416.7 61450.1 50069.0 50675.0 50693.2 50762.0 50762.7 16164.0 16241.2 16345.7 16398.1 16413.7 11065.7 12277.3 12400.8 12401.6 12451.1 19406.0 19635.5 20292.1 20300.8 20408.3 7551.4 7597.2 7603.3 7604.9 7648.2 1008.9 1014.2 1043.1 1105.4 1153.8 28231.7 28463.6 29871.1 29872.9 30522.8 1109.4 1122.9 1125.9 1205.9 1290.0 15520.2 16068.6 16162.3 16180.7 16186.4 372693.0 372786.0 373720.0 375022.0 378203.0 47182.0 47396.8 47423.3 47486.3 47525.5 1235.6 1282.6 1393.8 1394.9 1417.9 29657.0 31152.0 32267.4 32559.8 33181.2 39148.6 39485.8 39509.0 39515.6 39709.8 239588.0 240588.0 241318.0 242066.0 242572.0 27945.0 36219.3 48969.0 49096.3 49907.5 39624.0 40371.0 52022.0 52049.7 52702.7 38775.2 38848.0 41817.2 41858.8 43666.6 40759.6 41061.4 41528.4 41890.6 42506.8 42901.8 43446.6 44121.6 44611.3 44707.3 37454.4 38522.0 38716.2 38854.2 38929.8 29244.7 29258.4 29625.9 29629.1 30199.4 05:41:39 INFO - PROCESS | 7661 | 05:41:39 INFO - PROCESS | 7661 | [#2] jquery.html Cycles:180 Average:26828.31 Median:11623.02 stddev:74847.36 (644.0%) stddev-sans-first:75030.95 05:41:39 INFO - PROCESS | 7661 | Values: 361.8 377.7 377.9 381.7 387.6 17755.3 18127.3 18770.2 19093.7 19133.4 16797.8 16976.0 17748.7 17757.6 17790.9 5597.2 5733.3 5747.1 5760.2 5761.0 4014.6 5768.7 6119.1 6401.3 6422.7 6349.1 6361.8 6368.8 6392.9 6396.4 6059.9 6250.5 6328.2 6329.1 6340.1 3657.3 5260.1 5428.5 5483.5 5493.5 20156.2 20634.2 20771.0 21063.5 21103.2 2302.7 2648.8 3109.3 3112.2 3139.4 13173.8 13374.5 13475.9 13721.5 14027.3 1923.9 2048.4 2069.5 2099.3 2142.9 65632.7 65957.0 66001.0 68321.7 69400.3 10654.1 10707.8 10967.9 11035.3 11144.9 14375.8 14377.4 14463.2 14475.9 14479.9 8054.3 8272.7 8282.0 8372.7 8387.6 7870.0 7879.8 7954.5 7971.5 8061.5 6691.4 6792.7 6809.3 6818.3 6829.4 1727.2 1825.0 1861.2 1861.3 1900.2 945.6 996.7 1058.0 1075.6 1080.1 18279.0 18350.0 18401.7 19037.9 19308.4 1036.7 1045.1 1050.5 1067.6 1126.7 10409.6 10759.6 10810.8 10961.2 11206.9 451869.0 452376.0 453461.0 454682.0 471037.0 51243.0 62831.1 83543.0 84008.6 84391.2 1101.1 1115.6 1121.4 1175.6 1177.0 16359.0 16442.6 16449.4 16714.1 16831.2 36773.3 37353.4 38122.8 38136.6 38595.6 53518.0 53624.2 53695.5 53910.7 54318.5 7865.5 8071.8 8079.3 8127.6 8247.8 12332.2 12449.0 12727.5 12868.5 13130.6 8284.0 10367.3 10940.2 11227.3 11476.8 10598.3 10672.7 10922.2 11103.6 11501.4 11257.3 11328.9 11405.0 11443.8 11627.2 7969.4 7973.1 7996.1 8188.7 8217.9 10221.8 11515.8 11624.9 11644.9 11725.9 05:41:39 INFO - PROCESS | 7661 | 05:41:39 INFO - PROCESS | 7661 | [#3] mootools.html Cycles:180 Average:5496.44 Median:5910.29 stddev:2876.67 (48.7%) stddev-sans-first:2868.28 05:41:39 INFO - PROCESS | 7661 | Values: 1402.4 1495.9 1503.0 1670.2 1803.5 7346.0 7519.6 7563.2 7565.2 7570.6 7325.0 7493.1 7493.1 7494.3 7496.3 1893.2 2282.2 2321.9 2322.4 2344.9 2331.3 2342.3 2352.1 2353.9 2354.0 2280.6 2347.8 2366.0 2368.0 2370.5 2291.0 2301.3 2302.5 2303.4 2349.3 2213.6 2213.8 2217.9 2246.1 2287.4 7715.4 7763.1 7764.7 7767.2 7769.9 4936.4 5086.1 5087.5 5089.8 5093.1 3138.8 3231.8 3248.7 3315.6 3321.2 1045.5 1053.2 1053.5 1093.3 1104.9 10457.1 10725.8 10732.1 10736.3 10985.5 4207.9 4265.6 4298.0 4302.1 4343.5 8592.0 8595.0 8597.1 8603.1 8604.7 4336.6 4946.8 4954.8 4956.8 4958.5 4525.6 4609.6 4642.3 4650.8 4668.0 3624.4 3686.3 3704.9 3722.2 3724.5 1093.0 1115.4 1130.3 1131.3 1149.4 1038.9 1057.3 1059.8 1111.0 1181.5 7647.8 7704.3 7729.4 7748.2 7753.2 456.6 458.2 459.4 460.3 466.6 5529.6 5531.3 5557.9 5579.0 5580.8 9435.3 9616.4 9866.9 9867.3 9883.5 9640.6 9685.3 9770.0 9813.3 9827.9 7349.6 7398.3 7494.4 7518.5 7581.2 7410.1 7427.1 7445.2 7455.0 7470.1 8555.8 8590.0 8719.9 8725.2 8904.8 8759.3 8847.9 8864.1 9017.0 9031.1 5867.2 5953.4 5975.5 6676.9 6773.9 7339.0 7478.3 7483.5 7515.0 7545.5 6683.3 6875.5 6885.1 6953.4 7036.2 6695.8 6716.1 6759.2 6786.5 6993.4 7194.6 7213.3 7239.2 7248.3 7318.0 6662.7 6678.1 6709.0 6711.3 6715.3 6634.5 6683.3 6684.7 6715.1 6722.7 05:41:39 INFO - PROCESS | 7661 | 05:41:39 INFO - PROCESS | 7661 | [#4] prototype.html Cycles:180 Average:5153.52 Median:5924.53 stddev:1551.81 (26.2%) stddev-sans-first:1513.36 05:41:39 INFO - PROCESS | 7661 | Values: 331.1 331.6 336.7 336.7 337.0 5825.8 5849.4 5852.6 5855.0 5868.7 5812.8 5815.9 5816.1 5820.1 5840.2 4247.9 4346.0 4369.2 4459.7 4477.9 4443.3 4475.9 4483.6 4488.5 4489.3 4432.5 4433.3 4434.2 4439.0 4443.1 4249.4 4337.2 4423.0 4438.5 4444.1 3921.4 3927.3 3927.6 3928.2 3940.9 5590.9 5610.0 5626.5 5629.3 5633.7 5203.4 5204.0 5207.5 5210.6 5210.8 6125.4 6129.2 6131.8 6138.3 6141.9 4152.8 4267.5 4268.7 4383.3 4388.2 6413.8 6460.7 6475.7 6479.3 6490.7 4328.6 4334.5 4336.0 4339.6 4351.5 4405.3 4406.8 4408.2 4409.4 4416.8 5088.7 5097.3 5100.9 5102.4 5103.2 6007.5 6237.0 6240.4 6251.7 6252.2 1537.0 1546.6 1547.4 1550.4 1551.0 959.3 1032.4 1033.3 1042.2 1059.4 5920.5 5928.5 5928.9 5929.8 5930.8 6310.5 6329.1 6329.4 6330.1 6331.1 5964.8 5973.9 5974.9 5975.3 5979.3 3374.1 3401.4 3410.2 3412.9 3415.8 6400.8 6531.6 6553.5 6558.5 6563.5 6435.4 6439.8 6451.4 6479.2 6479.7 6501.7 6512.9 6517.4 6519.0 6521.8 6305.4 6360.9 6364.6 6364.7 6366.3 6042.1 6205.8 6210.1 6214.3 6222.9 6448.7 6499.8 6504.4 6512.7 6518.0 4376.1 4385.9 4390.2 4394.4 4406.2 6279.0 6282.2 6290.4 6291.7 6294.7 6113.8 6131.1 6134.2 6134.3 6144.8 6002.8 6083.5 6254.8 6261.7 6265.0 6134.4 6159.7 6160.0 6160.8 6162.9 6253.7 6272.1 6278.8 6283.7 6289.9 5841.8 5947.6 6083.6 6118.6 6130.5 05:41:39 INFO - PROCESS | 7661 | 05:41:39 INFO - PROCESS | 7661 | [#5] yui.html Cycles:180 Average:15160.28 Median:4759.01 stddev:17737.02 (372.7%) stddev-sans-first:17754.18 05:41:39 INFO - PROCESS | 7661 | Values: 839.6 851.5 857.9 859.5 859.9 13381.1 13780.0 13781.6 13804.9 13814.6 13683.0 13722.8 13726.7 13738.7 13762.0 633.4 797.1 807.6 809.3 822.4 781.8 792.0 793.4 793.7 801.8 850.8 852.3 852.8 855.2 869.8 672.7 830.5 862.7 867.0 868.9 629.7 629.8 630.1 630.5 630.6 13086.2 13166.9 13298.5 13335.6 13386.6 13123.5 13607.9 13626.1 13854.2 13924.5 11447.5 11464.0 11563.0 11694.6 11724.3 3768.8 3814.3 3837.0 3927.5 3946.9 54414.5 54546.5 54789.5 54979.5 55183.4 10125.1 10487.3 10717.0 10762.8 10910.4 18239.1 18410.1 19288.6 19339.7 19348.7 8276.9 8278.8 8344.4 8482.6 8607.5 4678.1 4725.3 4792.7 4798.0 4828.7 3271.6 3285.2 3290.9 3301.1 3321.2 586.9 599.7 607.8 610.9 621.2 616.6 699.0 742.3 747.5 753.2 9633.5 9750.4 9750.7 9755.7 9758.5 622.9 683.9 704.3 746.5 755.3 4425.3 4798.7 4806.8 4806.9 4824.0 60930.4 60963.0 61492.4 65248.7 66047.0 56559.7 57162.4 57273.4 57402.4 58505.1 52186.7 52348.0 52712.0 52799.2 53029.0 9792.7 9812.7 9865.2 9941.5 9944.3 37259.8 37391.0 37757.6 38008.2 38142.4 45922.5 46006.5 47057.8 51811.2 52125.2 11535.8 11935.8 11985.2 12180.5 12365.4 11614.0 12274.0 12529.8 13270.9 13679.9 12301.9 12357.8 12613.4 12881.8 13464.7 12632.4 12659.4 12664.4 12738.5 13163.9 12197.1 12768.1 12898.2 12906.3 13391.8 10424.0 10630.9 10774.4 11046.9 11249.0 10652.7 11028.7 11280.0 11295.4 11297.9 05:41:39 INFO - PROCESS | 7661 | -------- Summary: end -------- 05:41:39 INFO - PROCESS | 7661 | 05:41:40 INFO - TEST-INFO | 7661: exit 0 05:41:40 INFO - TEST-OK | dromaeo_css | took 1111120ms 05:41:40 INFO - TEST-START | kraken 05:41:40 INFO - operating with platform_type : linux_ 05:41:40 INFO - Initialising browser for kraken test... 05:41:40 INFO - TEST-INFO | started process 7847 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBMcwqI/profile http://localhost:57500/getInfo.html) 05:41:44 INFO - PROCESS | 7847 | __metrics Screen width/height:1600/1200 05:41:44 INFO - PROCESS | 7847 | colorDepth:24 05:41:44 INFO - PROCESS | 7847 | Browser inner width/height: 1024/697 05:41:44 INFO - PROCESS | 7847 | __metrics 05:41:45 ERROR - PROCESS | 7847 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:41:45 INFO - PROCESS | 7847 | 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. 05:41:46 INFO - TEST-INFO | 7847: exit 0 05:41:46 INFO - Browser initialized. 05:41:46 INFO - Running cycle 1/1 for kraken test... 05:41:46 INFO - TEST-INFO | started process 7931 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBMcwqI/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:41:58 INFO - PROCESS | 7931 | RSS: Main: 156033024 05:41:58 INFO - PROCESS | 7931 | 05:42:00 INFO - PROCESS | 7931 | Cycle 1(1): loaded http://localhost:57500/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57500/tests/kraken/driver.html?testName=audio-beat-detection) 05:42:01 INFO - PROCESS | 7931 | RSS: Main: 198082560 05:42:01 INFO - PROCESS | 7931 | 05:42:03 INFO - PROCESS | 7931 | Cycle 1(1): loaded http://localhost:57500/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57500/tests/kraken/driver.html?testName=audio-dft) 05:42:04 INFO - PROCESS | 7931 | RSS: Main: 186953728 05:42:04 INFO - PROCESS | 7931 | 05:42:07 INFO - PROCESS | 7931 | Cycle 1(1): loaded http://localhost:57500/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57500/tests/kraken/driver.html?testName=audio-fft) 05:42:08 INFO - PROCESS | 7931 | RSS: Main: 171511808 05:42:08 INFO - PROCESS | 7931 | 05:42:10 INFO - PROCESS | 7931 | Cycle 1(1): loaded http://localhost:57500/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57500/tests/kraken/driver.html?testName=audio-oscillator) 05:42:10 INFO - PROCESS | 7931 | RSS: Main: 174755840 05:42:10 INFO - PROCESS | 7931 | 05:42:12 INFO - PROCESS | 7931 | Cycle 1(1): loaded http://localhost:57500/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57500/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:42:13 INFO - PROCESS | 7931 | RSS: Main: 174260224 05:42:13 INFO - PROCESS | 7931 | 05:42:16 INFO - PROCESS | 7931 | Cycle 1(1): loaded http://localhost:57500/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57500/tests/kraken/driver.html?testName=imaging-darkroom) 05:42:16 INFO - PROCESS | 7931 | RSS: Main: 175104000 05:42:16 INFO - PROCESS | 7931 | 05:42:20 INFO - PROCESS | 7931 | Cycle 1(1): loaded http://localhost:57500/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57500/tests/kraken/driver.html?testName=imaging-desaturate) 05:42:20 INFO - PROCESS | 7931 | RSS: Main: 177037312 05:42:20 INFO - PROCESS | 7931 | 05:42:23 INFO - PROCESS | 7931 | Cycle 1(1): loaded http://localhost:57500/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57500/tests/kraken/driver.html?testName=json-parse-financial) 05:42:24 INFO - PROCESS | 7931 | RSS: Main: 177336320 05:42:24 INFO - PROCESS | 7931 | 05:42:25 INFO - PROCESS | 7931 | Cycle 1(1): loaded http://localhost:57500/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57500/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:42:26 INFO - PROCESS | 7931 | RSS: Main: 187817984 05:42:26 INFO - PROCESS | 7931 | 05:42:27 INFO - PROCESS | 7931 | Cycle 1(1): loaded http://localhost:57500/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57500/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:42:28 INFO - PROCESS | 7931 | RSS: Main: 184872960 05:42:28 INFO - PROCESS | 7931 | 05:42:30 INFO - PROCESS | 7931 | Cycle 1(1): loaded http://localhost:57500/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57500/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:42:31 INFO - PROCESS | 7931 | RSS: Main: 194756608 05:42:31 INFO - PROCESS | 7931 | 05:42:33 INFO - PROCESS | 7931 | Cycle 1(1): loaded http://localhost:57500/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57500/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:42:34 INFO - PROCESS | 7931 | RSS: Main: 199168000 05:42:34 INFO - PROCESS | 7931 | 05:42:36 INFO - PROCESS | 7931 | Cycle 1(1): loaded http://localhost:57500/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57500/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:42:37 INFO - PROCESS | 7931 | RSS: Main: 199221248 05:42:37 INFO - PROCESS | 7931 | 05:42:38 INFO - PROCESS | 7931 | Cycle 1(1): loaded http://localhost:57500/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57500/tests/kraken/driver.html?testName=ai-astar) 05:42:38 INFO - PROCESS | 7931 | RSS: Main: 259502080 05:42:38 INFO - PROCESS | 7931 | 05:42:38 INFO - PROCESS | 7931 | __start_tp_report 05:42:38 INFO - PROCESS | 7931 | _x_x_mozilla_page_load 05:42:38 INFO - PROCESS | 7931 | _x_x_mozilla_page_load_details 05:42:38 INFO - PROCESS | 7931 | |i|pagename|runs| 05:42:38 INFO - PROCESS | 7931 | |0;ai-astar;108;110;105;108;110;110;99;109;109;108 05:42:38 INFO - PROCESS | 7931 | |1;audio-beat-detection;158;134;153;167;127;155;153;127;176;126 05:42:38 INFO - PROCESS | 7931 | |2;audio-dft;163;161;162;161;164;161;161;166;163;161 05:42:38 INFO - PROCESS | 7931 | |3;audio-fft;76;73;107;96;72;75;72;127;100;73 05:42:38 INFO - PROCESS | 7931 | |4;audio-oscillator;92;94;141;92;93;93;142;93;92;138 05:42:38 INFO - PROCESS | 7931 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;117;117;118 05:42:38 INFO - PROCESS | 7931 | |6;imaging-darkroom;147;146;146;146;146;146;145;145;145;146 05:42:38 INFO - PROCESS | 7931 | |7;imaging-desaturate;96;96;96;95;95;95;95;95;95;95 05:42:38 INFO - PROCESS | 7931 | |8;json-parse-financial;56;56;56;55;56;55;56;64;54;54 05:42:38 INFO - PROCESS | 7931 | |9;json-stringify-tinderbox;60;60;60;62;61;61;61;61;60;60 05:42:38 INFO - PROCESS | 7931 | |10;stanford-crypto-aes;76;78;78;77;84;77;77;78;77;77 05:42:38 INFO - PROCESS | 7931 | |11;stanford-crypto-ccm;117;112;110;116;109;110;108;113;108;109 05:42:38 INFO - PROCESS | 7931 | |12;stanford-crypto-pbkdf2;134;135;134;135;133;124;137;135;138;134 05:42:38 INFO - PROCESS | 7931 | |13;stanford-crypto-sha256-iterative;61;62;62;62;62;62;64;62;62;60 05:42:38 INFO - PROCESS | 7931 | __end_tp_report 05:42:38 INFO - PROCESS | 7931 | __start_cc_report 05:42:38 INFO - PROCESS | 7931 | _x_x_mozilla_cycle_collect,1022 05:42:38 INFO - PROCESS | 7931 | __end_cc_report 05:42:38 INFO - PROCESS | 7931 | __startTimestamp1458736958910__endTimestamp 05:42:38 INFO - PROCESS | 7931 | 05:42:38 INFO - PROCESS | 7931 | ------- Summary: start ------- 05:42:38 INFO - PROCESS | 7931 | Number of tests: 14 05:42:38 INFO - PROCESS | 7931 | 05:42:38 INFO - PROCESS | 7931 | [#0] ai-astar Cycles:10 Average:107.60 Median:109.50 stddev:3.37 (3.1%) stddev-sans-first:3.57 05:42:38 INFO - PROCESS | 7931 | Values: 108.0 110.0 105.0 108.0 110.0 110.0 99.0 109.0 109.0 108.0 05:42:38 INFO - PROCESS | 7931 | 05:42:38 INFO - PROCESS | 7931 | [#1] audio-beat-detection Cycles:10 Average:147.60 Median:154.00 stddev:17.96 (11.7%) stddev-sans-first:18.66 05:42:38 INFO - PROCESS | 7931 | Values: 158.0 134.0 153.0 167.0 127.0 155.0 153.0 127.0 176.0 126.0 05:42:38 INFO - PROCESS | 7931 | 05:42:38 INFO - PROCESS | 7931 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.50 stddev:1.70 (1.0%) stddev-sans-first:1.79 05:42:38 INFO - PROCESS | 7931 | Values: 163.0 161.0 162.0 161.0 164.0 161.0 161.0 166.0 163.0 161.0 05:42:38 INFO - PROCESS | 7931 | 05:42:38 INFO - PROCESS | 7931 | [#3] audio-fft Cycles:10 Average:87.10 Median:73.00 stddev:19.31 (26.5%) stddev-sans-first:20.06 05:42:38 INFO - PROCESS | 7931 | Values: 76.0 73.0 107.0 96.0 72.0 75.0 72.0 127.0 100.0 73.0 05:42:38 INFO - PROCESS | 7931 | 05:42:38 INFO - PROCESS | 7931 | [#4] audio-oscillator Cycles:10 Average:107.00 Median:92.50 stddev:23.03 (24.9%) stddev-sans-first:23.78 05:42:38 INFO - PROCESS | 7931 | Values: 92.0 94.0 141.0 92.0 93.0 93.0 142.0 93.0 92.0 138.0 05:42:38 INFO - PROCESS | 7931 | 05:42:38 INFO - PROCESS | 7931 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 05:42:38 INFO - PROCESS | 7931 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 05:42:38 INFO - PROCESS | 7931 | 05:42:38 INFO - PROCESS | 7931 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 05:42:38 INFO - PROCESS | 7931 | Values: 147.0 146.0 146.0 146.0 146.0 146.0 145.0 145.0 145.0 146.0 05:42:38 INFO - PROCESS | 7931 | 05:42:38 INFO - PROCESS | 7931 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 05:42:38 INFO - PROCESS | 7931 | Values: 96.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 05:42:38 INFO - PROCESS | 7931 | 05:42:38 INFO - PROCESS | 7931 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:56.00 stddev:2.86 (5.1%) stddev-sans-first:3.03 05:42:38 INFO - PROCESS | 7931 | Values: 56.0 56.0 56.0 55.0 56.0 55.0 56.0 64.0 54.0 54.0 05:42:38 INFO - PROCESS | 7931 | 05:42:38 INFO - PROCESS | 7931 | [#9] json-stringify-tinderbox Cycles:10 Average:60.60 Median:61.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 05:42:38 INFO - PROCESS | 7931 | Values: 60.0 60.0 60.0 62.0 61.0 61.0 61.0 61.0 60.0 60.0 05:42:38 INFO - PROCESS | 7931 | 05:42:38 INFO - PROCESS | 7931 | [#10] stanford-crypto-aes Cycles:10 Average:77.90 Median:77.50 stddev:2.23 (2.9%) stddev-sans-first:2.26 05:42:38 INFO - PROCESS | 7931 | Values: 76.0 78.0 78.0 77.0 84.0 77.0 77.0 78.0 77.0 77.0 05:42:38 INFO - PROCESS | 7931 | 05:42:38 INFO - PROCESS | 7931 | [#11] stanford-crypto-ccm Cycles:10 Average:111.20 Median:111.00 stddev:3.22 (2.9%) stddev-sans-first:2.65 05:42:38 INFO - PROCESS | 7931 | Values: 117.0 112.0 110.0 116.0 109.0 110.0 108.0 113.0 108.0 109.0 05:42:38 INFO - PROCESS | 7931 | 05:42:38 INFO - PROCESS | 7931 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:133.90 Median:135.00 stddev:3.78 (2.8%) stddev-sans-first:4.01 05:42:38 INFO - PROCESS | 7931 | Values: 134.0 135.0 134.0 135.0 133.0 124.0 137.0 135.0 138.0 134.0 05:42:38 INFO - PROCESS | 7931 | 05:42:38 INFO - PROCESS | 7931 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.90 Median:62.00 stddev:0.99 (1.6%) stddev-sans-first:1.00 05:42:38 INFO - PROCESS | 7931 | Values: 61.0 62.0 62.0 62.0 62.0 62.0 64.0 62.0 62.0 60.0 05:42:38 INFO - PROCESS | 7931 | -------- Summary: end -------- 05:42:38 INFO - PROCESS | 7931 | 05:42:39 INFO - TEST-INFO | 7931: exit 0 05:42:39 INFO - TEST-OK | kraken | took 59325ms 05:42:39 INFO - SUITE-END | took 1170s 05:42:40 INFO - Completed test suite (00:19:30) 05:42:40 INFO - javascript benchmark 05:42:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2998.7001299870017, 3063.1423201503585, 3104.4722397192477, 3109.4869346557807, 3134.937301253974, 5186.247994040871, 5262.81580144695, 5288.788448462066, 5314.787408503656, 5327.866803329919, 5296.973515132419, 5321.122014867552, 5327.0, 5425.674459532421, 5438.91841622376, 4695.9530404696025, 4725.598324142444, 4921.4094308682825, 4945.455999840015, 4990.550850423461, 4696.295555666643, 4918.434380046287, 4934.0, 4940.431850337203, 4956.033573453178, 4707.31743897133, 4737.90524189516, 4760.952390476085, 4779.90440191196, 4805.279208118775, 4812.446568644581, 4822.541858523435, 4823.710577365334, 4835.951640483585, 4847.684900481458, 4636.374089497908, 4778.139934811733, 4821.927671084936, 4841.709497430165, 4887.975560122212, 5169.198774190007, 5193.350831146106, 5194.27280180775, 5200.6619569727845, 5211.817586384458, 5598.936202121584, 5607.243022192033, 5609.831705048855, 5610.074337734269, 5648.74580643872, 5492.340919089695, 5607.0, 5663.207150998864, 5767.913481297784, 5768.538516918637, 5270.578353731692, 5307.230451584537, 5357.973210133963, 5362.705051222181, 5383.811566595189, 5852.15143804146, 5871.089981052944, 5877.647341159544, 5880.0, 5885.529157667376, 5412.5940554458575, 5491.807786727445, 5578.581606379537, 5608.158776183605, 5635.605507614428, 5630.8029218977135, 5636.802711905064, 5640.153976903497, 5640.182173584889, 5647.209390685307, 5437.918431223535, 5557.916206339806, 5560.277163968739, 5561.360443548962, 5565.2486914266865, 5563.443655634485, 5614.382417934024, 5627.155926610959, 5642.520385767174, 5676.687782171937, 4258.7657678827345, 4261.147770445861, 4271.8718438446895, 4297.763623000703, 4298.634616057608, 3747.7189210809297, 3781.262653782486, 3810.1236715555024, 3828.8277027533827, 3850.0182453474185, 5405.567554595623, 5419.945800541944, 5425.267588875451, 5442.2380866678695, 5473.808416705476, 5725.312962444534, 5740.799072032459, 5758.280214973129, 5761.971190144022, 5763.221965034667, 5220.556252718561, 5359.517643412111, 5422.430644782241, 5424.186372044225, 5445.233174588909, 4869.659123861366, 4882.511748825089, 4882.6826256293225, 4906.533879281463, 4923.581495572845, 5854.268216472941, 5858.355580886099, 5858.589898707135, 5861.531077513789, 5863.384344643751, 5524.309461317335, 5670.74481648335, 5696.686682232517, 5770.6249093808765, 5779.595428320145, 5848.561357898089, 5850.678212698343, 5854.092615644582, 5857.4435428634215, 5863.912041319299, 5570.303712035996, 5570.470805273492, 5572.721363931868, 5577.051901176728, 5585.441455854382, 5598.468145526169, 5655.038643430545, 5709.8287051388525, 5713.485786279255, 5756.30924289088, 5553.389127196086, 5561.388247292875, 5565.833025009256, 5578.470045345685, 5584.916226256691, 5307.867303317448, 5528.799365171252, 5528.91706624409, 5536.335639723259, 5538.47384498472, 5502.394736578893, 5551.084071128219, 5570.053090974463, 5582.441755824548, 5611.551075913835, 5576.749046292845, 5578.525825304894, 5592.077307244422, 5596.832095037155, 5607.579431542569, 5355.196720491957, 5488.0, 5504.697241651747, 5530.861728456821, 5557.749901254534], "unit": "score", "name": "dojo.html", "value": 5224.314341236396}, {"lowerIsBetter": false, "replicates": [558.2009426315047, 568.8350378390267, 576.4091805898954, 597.7310210405317, 599.6132494541024, 37272.0, 37648.43527347092, 37650.43524347134, 37661.0, 37718.811405942935, 41154.0, 41375.58624413755, 41672.79163604185, 41743.16513669725, 41899.581004189946, 8344.332453403713, 8658.696945606873, 8669.913300866974, 8673.913260867404, 8677.522736249504, 8573.442726222807, 8709.25971292441, 8726.254749050184, 8729.388942774009, 8733.825323493526, 8858.645654173826, 9006.86489702655, 9007.909920900773, 9013.774655633597, 9016.819663606724, 8859.601317940707, 8879.067697891693, 8941.374103812735, 8945.507997060158, 8951.73144805657, 8749.737507874774, 9008.28842519919, 9012.819743605156, 9014.459132452073, 9022.7293181204, 40839.183216335805, 41126.177476450306, 41174.0, 41181.0, 41193.0, 3439.8108104054268, 3717.033571271462, 3833.846646134179, 4038.7778672173017, 4355.651547876162, 31354.05937821869, 31979.52030719541, 32186.0, 32251.83874080638, 33015.17462063444, 4226.725262857935, 4244.490661120685, 4247.439671563105, 4330.39374487572, 4375.628071613916, 296522.0, 299547.0, 300681.9999999978, 300916.0, 301362.0, 53379.46620533745, 60209.0, 61347.0, 61416.69291653513, 61450.07824882631, 50069.0, 50675.0, 50693.23960140601, 50762.0, 50762.74618626957, 16164.0, 16241.187940602922, 16345.673086538203, 16398.09810460436, 16413.6717265654, 11065.668029959113, 12277.263364198177, 12400.75198496043, 12401.62795116148, 12451.066170037102, 19406.0, 19635.496202253627, 20292.08685609151, 20300.79699202989, 20408.285710000375, 7551.395888328921, 7597.164311925684, 7603.315701586773, 7604.885926711104, 7648.235176482419, 1008.9041541053588, 1014.1937159957852, 1043.1446214104362, 1105.4086063955745, 1153.8269259611125, 28231.71768282332, 28463.57304640432, 29871.103866884027, 29872.850635746683, 30522.847385763373, 1109.4175557832202, 1122.887711228887, 1125.8648962124598, 1205.9035277177804, 1289.9935500322438, 15520.183901640343, 16068.598285042734, 16162.272697728631, 16180.67638647244, 16186.433474828324, 372693.0, 372786.0, 373720.0, 375022.0, 378203.0, 47182.0, 47396.7630161847, 47423.28865067027, 47486.287705684445, 47525.52474475211, 1235.5922545560124, 1282.602393258093, 1393.7560926837764, 1394.8884089272833, 1417.8723914847712, 29657.0, 31152.0, 32267.35465290728, 32559.837200813843, 33181.17047073843, 39148.6085139145, 39485.80257098696, 39509.0, 39515.604843951194, 39709.80145099371, 239588.0, 240588.0, 241318.0, 242066.0, 242572.0, 27945.0, 36219.27561448809, 48969.0, 49096.263556045975, 49907.50092499029, 39624.0, 40371.0, 52022.0, 52049.739751301, 52702.73648631732, 38775.2244955105, 38848.0, 41817.1636567273, 41858.790706046275, 43666.56333436625, 40759.59240407558, 41061.38407923824, 41528.37707434451, 41890.58109418867, 42506.78746606247, 42901.78549107235, 43446.56553434425, 44121.55878441175, 44611.33083003823, 44707.32939005983, 37454.438183426726, 38522.0, 38716.225675485766, 38854.222915542094, 38929.80535097307, 29244.70755292505, 29258.414831703674, 29625.85187074051, 29629.111126666234, 30199.396012080077], "unit": "score", "name": "ext.html", "value": 19356.794651573113}, {"lowerIsBetter": false, "replicates": [361.7540072750529, 377.67897287305794, 377.8601917290602, 381.6507895275823, 387.56214444411233, 17755.289788408463, 18127.27490900364, 18770.155343009563, 19093.713594296096, 19133.42599722007, 16797.83202167978, 16976.0, 17748.733768993443, 17757.64484710305, 17790.911045444755, 5597.244372009777, 5733.283339582552, 5747.109198074305, 5760.164776107462, 5761.0, 4014.5784692607294, 5768.653880767147, 6119.112728654342, 6401.327860574643, 6422.743090276384, 6349.111124442582, 6361.809145725636, 6368.777092801753, 6392.872142557146, 6396.392342727457, 6059.909101363483, 6250.5312101592335, 6328.1773369462135, 6329.050642403653, 6340.080688300193, 3657.2502636959625, 5260.079486089957, 5428.45715428458, 5483.451654834525, 5493.505584497414, 20156.193752249892, 20634.17463301466, 20771.0, 21063.47341316464, 21103.15587376503, 2302.7121609798774, 2648.8278261913106, 3109.347037122207, 3112.1597168764306, 3139.4035133324824, 13173.802392964113, 13374.531891383755, 13475.86524134756, 13721.519746808814, 14027.298635068206, 1923.913423895928, 2048.3957232616413, 2069.503319203395, 2099.349201747463, 2142.882141482218, 65632.67183664051, 65957.0, 66001.0, 68321.65839170772, 69400.30599693989, 10654.147668186526, 10707.785844283071, 10967.945160274148, 11035.337879727242, 11144.944275278573, 14375.78436323456, 14377.424903003763, 14463.204523751085, 14475.855241447662, 14479.85520144785, 8054.275115239657, 8272.669093236203, 8282.0, 8372.748817535483, 8387.580620968927, 7869.993151746268, 7879.803004924923, 7954.482958607672, 7971.481853679492, 8061.4760040597175, 6691.431228345547, 6792.694328755218, 6809.270931559899, 6818.261343357412, 6829.351211634887, 1727.1623262717571, 1824.9908750456163, 1861.2275905499337, 1861.3485280151838, 1900.2304066852946, 945.635930166877, 996.6611352140308, 1057.9735506612242, 1075.5751478166237, 1080.0927221134127, 18279.0, 18349.99075050885, 18401.723974140397, 19037.90481047586, 19308.4207473776, 1036.7252678040325, 1045.1482042135635, 1050.5115121468555, 1067.5516283161091, 1126.7014241226082, 10409.583616655249, 10759.569617215224, 10810.837837432446, 10961.177911656658, 11206.887931120747, 451869.0, 452376.0, 453461.0, 454682.0, 471037.0, 51243.0, 62831.05753413703, 83543.0, 84008.57995710104, 84391.15608843956, 1101.0805977009286, 1115.570505355444, 1121.43928035982, 1175.5591653130077, 1177.0, 16359.0, 16442.588935276715, 16449.424270150488, 16714.080725559725, 16831.158442078093, 36773.26453470862, 37353.439698404, 38122.809385952896, 38136.61863381442, 38595.614043859205, 53518.0, 53624.19563706625, 53695.46304536905, 53910.730446347516, 54318.45681543292, 7865.528068315919, 8071.83856322882, 8079.272865442138, 8127.593620318842, 8247.835043299221, 12332.19840710351, 12449.0, 12727.490900364252, 12868.549600763929, 13130.606081817561, 8284.0, 10367.32612380193, 10940.179486538382, 11227.326360418401, 11476.770464590829, 10598.31110977784, 10672.679819605424, 10922.18083643714, 11103.555857765921, 11501.367424791382, 11257.268277561932, 11328.94335528317, 11405.0, 11443.771124577628, 11627.244229125079, 7969.442139050443, 7973.083095443866, 7996.120426753168, 8188.713395031145, 8217.917820821714, 10221.795564088825, 11515.769684606094, 11624.88375116238, 11644.941775291069, 11725.941370293094], "unit": "score", "name": "jquery.html", "value": 9149.832159773816}, {"lowerIsBetter": false, "replicates": [1402.389960367241, 1495.8653721165092, 1502.9549113526596, 1670.1899578704326, 1803.5220666523373, 7345.963270183648, 7519.586422746746, 7563.205863384348, 7565.243475652445, 7570.621468926553, 7325.0, 7493.063367079115, 7493.1008279006455, 7494.288042635954, 7496.250374962501, 1893.1764682363148, 2282.224043825099, 2321.895514701834, 2322.3613506285824, 2344.941376465585, 2331.265651319837, 2342.285602891126, 2352.1061996441326, 2353.9411514712097, 2353.9882300588474, 2280.623697089978, 2347.80043696286, 2365.9826274701873, 2368.0409434179187, 2370.4547953970596, 2290.977090229093, 2301.2981040782556, 2302.5394921015695, 2303.4126297794037, 2349.3304408243653, 2213.5683541709373, 2213.756486786452, 2217.8669279843098, 2246.067881829039, 2287.3824067501846, 7715.382769378436, 7763.107242667109, 7764.689412423496, 7767.18444563324, 7769.922300776976, 4936.358273424467, 5086.059079070347, 5087.49125087492, 5089.821856235051, 5093.0577843099145, 3138.7959782614057, 3231.8060916345094, 3248.7238584720326, 3315.5855518060243, 3321.186309354224, 1045.4772613693153, 1053.1522124689623, 1053.510117795229, 1093.3330668292335, 1104.8895110488968, 10457.111145552637, 10725.83911241332, 10732.087772539266, 10736.30214036085, 10985.505652245669, 4207.894802629959, 4265.55211702773, 4298.032942587893, 4302.053548219386, 4343.543927887589, 8591.957040214758, 8595.0, 8597.097304783032, 8603.139686031347, 8604.741857744277, 4336.6313863321975, 4946.777395017233, 4954.752262386866, 4956.752162391938, 4958.479359667183, 4525.615322697542, 4609.562091601292, 4642.303654451859, 4650.837220697259, 4668.0197158597075, 3624.4382120771324, 3686.299603075407, 3704.851496036237, 3722.16251343451, 3724.5344331958504, 1093.0, 1115.4199816095586, 1130.2935665209245, 1131.2703306367348, 1149.3793351590048, 1038.8753349597946, 1057.281048886749, 1059.8304271316551, 1110.9888901110885, 1181.5214837990627, 7647.808804779925, 7704.26809453101, 7729.4202934779, 7748.186440423674, 7753.1859154787935, 456.6324109092146, 458.2175337935434, 459.4096585887119, 460.26357827476437, 466.55677106748726, 5529.557635389159, 5531.308586426697, 5557.861053473695, 5579.0, 5580.776768929279, 9435.292353073546, 9616.423014619146, 9866.901330986742, 9867.259955503367, 9883.505824708736, 9640.614375424904, 9685.32202745801, 9769.951150244346, 9813.264005199639, 9827.901720982698, 7349.63251837406, 7398.297161769623, 7494.362979146725, 7518.511296765692, 7581.166071732105, 7410.11078670563, 7427.071616047994, 7445.181030086578, 7454.962725186339, 7470.103587569526, 8555.82888342242, 8590.012148602991, 8719.869201961848, 8725.171108744658, 8904.777380565538, 8759.299256059627, 8847.867281990904, 8864.06927272627, 9016.954915225644, 9031.096890311179, 5867.178594996789, 5953.404659534012, 5975.462208401264, 6676.9332306676315, 6773.93226067733, 7339.0, 7478.2521747824785, 7483.476156668981, 7514.9624251878395, 7545.50954187976, 6683.264840867598, 6875.518713689994, 6885.139357580302, 6953.443724502129, 7036.19083805369, 6695.799126026227, 6716.126903502709, 6759.222689390783, 6786.524943253925, 6993.405560527209, 7194.604296763729, 7213.314735100157, 7239.239879812544, 7248.275172482709, 7317.963410182915, 6662.666866656745, 6678.098456708476, 6709.027191057172, 6711.328867113445, 6715.328467153246, 6634.502412318999, 6683.264840867598, 6684.665766711742, 6715.093462382516, 6722.697478613572], "unit": "score", "name": "mootools.html", "value": 4422.001968896913}, {"lowerIsBetter": false, "replicates": [331.08455121588804, 331.5987654937525, 336.6952907618606, 336.73398015567693, 336.98652053917846, 5825.796097136601, 5849.385814489481, 5852.561057920651, 5855.0, 5868.677222752747, 5812.767489300433, 5815.854603634912, 5816.098504731774, 5820.068788993762, 5840.153177789218, 4247.872563823083, 4346.043870348518, 4369.235383807837, 4459.687821852472, 4477.865664030068, 4443.289073748201, 4475.910481790363, 4483.574060464267, 4488.496353721507, 4489.2817149256125, 4432.468103827545, 4433.2685106957315, 4434.17967675981, 4438.977805110986, 4443.111377724452, 4249.405083288342, 4337.1976184405985, 4423.0, 4438.489573699034, 4444.133393988173, 3921.4117882317883, 3927.3127202739406, 3927.586069015152, 3928.194720082376, 3940.9211815763524, 5590.944090559124, 5609.971950140264, 5626.508975121596, 5629.324481062258, 5633.718314084321, 5203.375594928595, 5204.0372531081875, 5207.531322181022, 5210.557102646279, 5210.76551555181, 6125.356837532084, 6129.233845769279, 6131.816045518642, 6138.294096178952, 6141.938580614182, 4152.8131234094535, 4267.487901451815, 4268.679849011337, 4383.276759334706, 4388.166248412791, 6413.807585772434, 6460.709268082947, 6475.7085931133215, 6479.287278399373, 6490.675466226669, 4328.632066274339, 4334.544872788375, 4336.0, 4339.566043395698, 4351.4995775485595, 4405.31717583775, 4406.801693923781, 4408.228560001987, 4409.3606427068535, 4416.757078360657, 5088.72012039334, 5097.311862898536, 5100.872478188075, 5102.36220472441, 5103.209002604603, 6007.549433792483, 6237.0, 6240.375962403723, 6251.687415629201, 6252.218472690914, 1536.9769453458207, 1546.5901536092945, 1547.411983446283, 1550.3720992997853, 1550.999605254627, 959.3236768078488, 1032.4321623107262, 1033.2767063055892, 1042.2027149230844, 1059.4120263253967, 5920.526357891358, 5928.525717942554, 5928.881422371528, 5929.762809487572, 5930.762769489258, 6310.495160387158, 6329.145565348711, 6329.398707122816, 6330.082138090043, 6331.050342448578, 5964.761409543657, 5973.940260597426, 5974.850628734316, 5975.342712301644, 5979.312379076375, 3374.122728090665, 3401.4387626041425, 3410.1645096951406, 3412.8805491807666, 3415.7608967372043, 6400.839979000562, 6531.640759758164, 6553.475721942328, 6558.508111891627, 6563.474922006228, 6435.388638079468, 6439.774607888701, 6451.387118223761, 6479.157709497829, 6479.7408103675325, 6501.739930402826, 6512.869742605027, 6517.4134327910715, 6518.967405162944, 6521.836954076186, 6305.4009869062365, 6360.9045864313, 6364.64994425311, 6364.713587888464, 6366.299707032315, 6042.123892035718, 6205.782797602063, 6210.099535567227, 6214.2853571838, 6222.906656400067, 6448.709808058742, 6499.805005849643, 6504.414602685781, 6512.674366281762, 6517.967410162919, 4376.12477504494, 4385.890352741207, 4390.209762242827, 4394.362817391524, 4406.184855801687, 6278.963970944743, 6282.1519094921605, 6290.433860952537, 6291.716872740646, 6294.748210071546, 6113.84715382119, 6131.080337949344, 6134.171886795404, 6134.263888333428, 6144.754209831557, 6002.849928751816, 6083.482903953037, 6254.781082662085, 6261.7182226799, 6265.028920517327, 6134.38656134383, 6159.6612186330185, 6159.9836027055035, 6160.753569857335, 6162.938370616236, 6253.6560489173535, 6272.09054687077, 6278.8430289241305, 6283.685815709287, 6289.905651415141, 5841.795537156179, 5947.613405128653, 6083.574149809471, 6118.632882027093, 6130.47890929276], "unit": "score", "name": "prototype.html", "value": 4648.887854863407}, {"lowerIsBetter": false, "replicates": [839.5969934431471, 851.4593233296855, 857.8976015819673, 859.4757198109153, 859.9269062129719, 13381.063325567202, 13780.035397522164, 13781.58655240343, 13804.861951380482, 13814.585562433118, 13683.0, 13722.794158087636, 13726.656833579165, 13738.725225495484, 13762.0, 633.4109278371113, 797.0833541427347, 807.6284908941893, 809.3282575462352, 822.411975437562, 781.8358144789601, 792.0416296281506, 793.4326956226297, 793.6507936507946, 801.7835184500182, 850.8213275212213, 852.2883392367349, 852.8251708399794, 855.2046596665099, 869.7695110795644, 672.6872004517899, 830.5141492227024, 862.7282406042077, 867.020267098175, 868.8696695495663, 629.6725702634604, 629.7953165221321, 630.095812509051, 630.533405280094, 630.6184758221256, 13086.214827110403, 13166.934165329112, 13298.468061277537, 13335.599932002055, 13386.598402047954, 13123.54067607629, 13607.931960340235, 13626.110986630876, 13854.16874987504, 13924.51264205758, 11447.484863181176, 11464.0, 11563.0, 11694.649160525198, 11724.296542207494, 3768.7550309229814, 3814.275287695329, 3836.9616303836883, 3927.528696556403, 3946.921061578781, 54414.45585544134, 54546.454535454934, 54789.452105478835, 54979.45020549784, 55183.44816551823, 10125.139363154067, 10487.26589138753, 10717.0, 10762.78474430507, 10910.399928003877, 18239.088045597666, 18410.079496025144, 19288.614227715367, 19339.709904351446, 19348.70976935347, 8276.875846862302, 8278.793030174294, 8344.374171937008, 8482.575871206538, 8607.48355098696, 4678.087772884255, 4725.315608025965, 4792.7124372537755, 4797.95202047982, 4828.734419606885, 3271.5583396241204, 3285.227971426713, 3290.8848190313224, 3301.1417031571964, 3321.2029113013186, 586.9325027621878, 599.66718471248, 607.8389226854887, 610.9053096770008, 621.1676353686082, 616.6176970278456, 698.979030629082, 742.2985278911485, 747.5178509861217, 753.1677496366545, 9633.518324083769, 9750.414975101517, 9750.707478775648, 9755.661679292241, 9758.463284519277, 622.8847663182326, 683.9452843772486, 704.281632734618, 746.4998451037818, 755.316438623047, 4425.269830477935, 4798.736069516141, 4806.831760888352, 4806.927896081562, 4823.975880120577, 60930.39069609247, 60963.0, 61492.38507614867, 65248.67375663092, 66047.0, 56559.71720141373, 57162.42837571654, 57273.42726572681, 57402.425975740545, 58505.12242316369, 52186.73906630443, 52348.0, 52712.0, 52799.208011879855, 53029.0, 9792.657256995972, 9812.65655702047, 9865.210783137476, 9941.502924853872, 9944.254180936314, 37259.81370093132, 37391.0, 37757.62242377651, 38008.23983520369, 38142.42786358151, 45922.54077459183, 46006.53993460022, 47057.76471117623, 51811.222831658306, 52125.21812172745, 11535.769284614093, 11935.82096268574, 11985.22096063753, 12180.512779488721, 12365.38173091324, 11614.0, 12274.0, 12529.812052819032, 13270.867291326964, 13679.863201368256, 12301.890180936518, 12357.75284494323, 12613.369331533204, 12881.8067728986, 13464.663383415493, 12632.431540580512, 12659.367031648564, 12664.430100645677, 12738.490460381852, 13163.868361316265, 12197.085218608463, 12768.106232563632, 12898.161619494704, 12906.290154041242, 13391.799123012968, 10424.0, 10630.946845265724, 10774.414140606355, 11046.944765276123, 11249.0, 10652.680419587425, 11028.669139925814, 11280.0, 11295.435228238719, 11297.943510282395], "unit": "score", "name": "yui.html", "value": 6801.338451170918}], "name": "dromaeo_css", "value": 7111.808610593418}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 110.0, 105.0, 108.0, 110.0, 110.0, 99.0, 109.0, 109.0, 108.0], "unit": "score", "name": "ai-astar", "value": 107.6}, {"lowerIsBetter": true, "replicates": [158.0, 134.0, 153.0, 167.0, 127.0, 155.0, 153.0, 127.0, 176.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 147.6}, {"lowerIsBetter": true, "replicates": [163.0, 161.0, 162.0, 161.0, 164.0, 161.0, 161.0, 166.0, 163.0, 161.0], "unit": "score", "name": "audio-dft", "value": 162.3}, {"lowerIsBetter": true, "replicates": [76.0, 73.0, 107.0, 96.0, 72.0, 75.0, 72.0, 127.0, 100.0, 73.0], "unit": "score", "name": "audio-fft", "value": 87.1}, {"lowerIsBetter": true, "replicates": [92.0, 94.0, 141.0, 92.0, 93.0, 93.0, 142.0, 93.0, 92.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 107.0}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.0}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [56.0, 56.0, 56.0, 55.0, 56.0, 55.0, 56.0, 64.0, 54.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.2}, {"lowerIsBetter": true, "replicates": [60.0, 60.0, 60.0, 62.0, 61.0, 61.0, 61.0, 61.0, 60.0, 60.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 60.6}, {"lowerIsBetter": true, "replicates": [76.0, 78.0, 78.0, 77.0, 84.0, 77.0, 77.0, 78.0, 77.0, 77.0], "unit": "score", "name": "stanford-crypto-aes", "value": 77.9}, {"lowerIsBetter": true, "replicates": [117.0, 112.0, 110.0, 116.0, 109.0, 110.0, 108.0, 113.0, 108.0, 109.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 111.2}, {"lowerIsBetter": true, "replicates": [134.0, 135.0, 134.0, 135.0, 133.0, 124.0, 137.0, 135.0, 138.0, 134.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 133.9}, {"lowerIsBetter": true, "replicates": [61.0, 62.0, 62.0, 62.0, 62.0, 62.0, 64.0, 62.0, 62.0, 60.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 61.9}], "name": "kraken", "value": 1471.4000000000003}]} 05:42:40 INFO - Return code: 0 05:42:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:42:40 ERROR - # TBPL SUCCESS # 05:42:40 INFO - Running post-action listener: _resource_record_post_action 05:42:40 INFO - Running post-run listener: _resource_record_post_run 05:42:41 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 495616; Write bytes: 284463104; Read time: 56; Write time: 170024 05:42:41 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 1306624; Read time: 0; Write time: 76 05:42:41 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 495616; Write bytes: 283156480; Read time: 56; Write time: 169948 05:42:41 INFO - Running post-run listener: _upload_blobber_files 05:42:41 INFO - Blob upload gear active. 05:42:41 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:42:41 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 05:42:41 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'] 05:42:41 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 05:42:41 INFO - (blobuploader) - INFO - Open directory for files ... 05:42:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:42:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:42:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:42:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:42:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:42:42 INFO - (blobuploader) - INFO - Done attempting. 05:42:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 05:42:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:42:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:42:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:42:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:42:43 INFO - (blobuploader) - INFO - Done attempting. 05:42:43 INFO - (blobuploader) - INFO - Iteration through files over. 05:42:43 INFO - Return code: 0 05:42:43 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:42:43 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:42:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0490ec5c845db9902f75bed88f207948a711b2ba4f253ab30ca7aab92dd4be9142d9f2cedc48874bde8eabcc73c451f4f71088f0b50c5b9bfdf6b4c9bd4ceb95", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d012c7dff1084f42a24bae0ee5fa90564ce73a5ec05c374874451fdfd63322c4e2a26c415c3a64394065dc6f6781eaf8cbd9aa6740dd0c95dabd03c053fb2829"} 05:42:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:42:43 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:42:43 INFO - Contents: 05:42:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0490ec5c845db9902f75bed88f207948a711b2ba4f253ab30ca7aab92dd4be9142d9f2cedc48874bde8eabcc73c451f4f71088f0b50c5b9bfdf6b4c9bd4ceb95", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d012c7dff1084f42a24bae0ee5fa90564ce73a5ec05c374874451fdfd63322c4e2a26c415c3a64394065dc6f6781eaf8cbd9aa6740dd0c95dabd03c053fb2829"} 05:42:43 INFO - Running post-run listener: copy_logs_to_upload_dir 05:42:43 INFO - Copying logs to upload dir... 05:42:43 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 05:42:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1226.324844 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-03-23 05:42:43.649413) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-23 05:42:43.655065) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1458735733.244411-1535115106 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/0490ec5c845db9902f75bed88f207948a711b2ba4f253ab30ca7aab92dd4be9142d9f2cedc48874bde8eabcc73c451f4f71088f0b50c5b9bfdf6b4c9bd4ceb95", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d012c7dff1084f42a24bae0ee5fa90564ce73a5ec05c374874451fdfd63322c4e2a26c415c3a64394065dc6f6781eaf8cbd9aa6740dd0c95dabd03c053fb2829"} build_url:https://queue.taskcluster.net/v1/task/dMIKjra5StylsDvFzb_NDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011320 build_url: 'https://queue.taskcluster.net/v1/task/dMIKjra5StylsDvFzb_NDA/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/0490ec5c845db9902f75bed88f207948a711b2ba4f253ab30ca7aab92dd4be9142d9f2cedc48874bde8eabcc73c451f4f71088f0b50c5b9bfdf6b4c9bd4ceb95", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d012c7dff1084f42a24bae0ee5fa90564ce73a5ec05c374874451fdfd63322c4e2a26c415c3a64394065dc6f6781eaf8cbd9aa6740dd0c95dabd03c053fb2829"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-23 05:42:43.682738) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 05:42:43.683071) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1458735733.244411-1535115106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004535 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 05:42:43.768139) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-23 05:42:43.768847) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-23 05:42:43.769151) ========= ========= Total master_lag: 0.29 =========