builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-035 starttime: 1455182475.2 results: success (0) buildid: 20160210223010 builduid: b78084be8b85488db3a68438ffaf1b75 revision: 97c7a71cce023044f6c1bf84d8a3a0affa7cc219 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-11 01:21:15.196315) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-11 01:21:15.196734) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-11 01:21:15.197035) ========= 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=ed14279e38b05397cf4aa391000001a4-1455181951.930554-820759853 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006359 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.38 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-11 01:21:15.587291) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-11 01:21:15.587604) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-11 01:21:15.669828) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 01:21:15.670076) ========= 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=ed14279e38b05397cf4aa391000001a4-1455181951.930554-820759853 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004548 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 01:21:15.749754) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-11 01:21:15.750032) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-11 01:21:15.750394) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 01:21:15.750671) ========= 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=ed14279e38b05397cf4aa391000001a4-1455181951.930554-820759853 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-11 01:21:15-- 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% 209M=0s 2016-02-11 01:21:15 (209 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.108203 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 01:21:15.881722) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 01:21:15.884105) ========= 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=ed14279e38b05397cf4aa391000001a4-1455181951.930554-820759853 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.129206 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 01:21:16.032040) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 01:21:16.032350) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 97c7a71cce023044f6c1bf84d8a3a0affa7cc219 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 97c7a71cce023044f6c1bf84d8a3a0affa7cc219 --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=ed14279e38b05397cf4aa391000001a4-1455181951.930554-820759853 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-11 01:21:16,121 truncating revision to first 12 chars 2016-02-11 01:21:16,121 Setting DEBUG logging. 2016-02-11 01:21:16,121 attempt 1/10 2016-02-11 01:21:16,121 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/97c7a71cce02?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-11 01:21:16,382 unpacking tar archive at: mozilla-inbound-97c7a71cce02/testing/mozharness/ program finished with exit code 0 elapsedTime=0.549039 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 01:21:16.598101) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-11 01:21:16.598471) ========= echo 97c7a71cce023044f6c1bf84d8a3a0affa7cc219 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'97c7a71cce023044f6c1bf84d8a3a0affa7cc219'] 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=ed14279e38b05397cf4aa391000001a4-1455181951.930554-820759853 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 97c7a71cce023044f6c1bf84d8a3a0affa7cc219 program finished with exit code 0 elapsedTime=0.003868 script_repo_revision: '97c7a71cce023044f6c1bf84d8a3a0affa7cc219' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-11 01:21:16.651805) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-11 01:21:16.652085) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-11 01:21:16.662183) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-02-11 01:21:16.662768) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ed14279e38b05397cf4aa391000001a4-1455181951.930554-820759853 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:21:16 INFO - MultiFileLogger online at 20160211 01:21:16 in /builds/slave/test-pgo 01:21:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 01:21:16 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 01:21:16 INFO - {'append_to_log': False, 01:21:16 INFO - 'base_work_dir': '/builds/slave/test-pgo', 01:21:16 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 01:21:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 01:21:16 INFO - 'branch': 'Mozilla-Inbound', 01:21:16 INFO - 'buildbot_json_path': 'buildprops.json', 01:21:16 INFO - 'config_files': ('talos/linux_config.py',), 01:21:16 INFO - 'default_actions': ('clobber', 01:21:16 INFO - 'read-buildbot-config', 01:21:16 INFO - 'download-and-extract', 01:21:16 INFO - 'populate-webroot', 01:21:16 INFO - 'create-virtualenv', 01:21:16 INFO - 'install', 01:21:16 INFO - 'run-tests'), 01:21:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:21:16 INFO - 'download_minidump_stackwalk': True, 01:21:16 INFO - 'download_symbols': 'ondemand', 01:21:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:21:16 INFO - 'tooltool.py': '/tools/tooltool.py', 01:21:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:21:16 INFO - '/tools/misc-python/virtualenv.py')}, 01:21:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:21:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:21:16 INFO - 'installer_path': 'installer.exe', 01:21:16 INFO - 'log_level': 'info', 01:21:16 INFO - 'log_name': 'talos', 01:21:16 INFO - 'log_to_console': True, 01:21:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:21:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:21:16 INFO - 'opt_config_files': (), 01:21:16 INFO - 'pip_index': False, 01:21:16 INFO - 'sps_profile': False, 01:21:16 INFO - 'sps_profile_interval': 0, 01:21:16 INFO - 'suite': 'dromaeojs', 01:21:16 INFO - 'system_bits': '32', 01:21:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:21:16 INFO - 'title': 'talos-linux64-ix-035', 01:21:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:21:16 INFO - 'use_talos_json': True, 01:21:16 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 01:21:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:21:16 INFO - 'work_dir': 'build'} 01:21:16 INFO - ##### 01:21:16 INFO - ##### Running clobber step. 01:21:16 INFO - ##### 01:21:16 INFO - Running pre-action listener: _resource_record_pre_action 01:21:16 INFO - Running main action method: clobber 01:21:16 INFO - rmtree: /builds/slave/test-pgo/build 01:21:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 01:21:22 INFO - Running post-action listener: _resource_record_post_action 01:21:22 INFO - ##### 01:21:22 INFO - ##### Running read-buildbot-config step. 01:21:22 INFO - ##### 01:21:22 INFO - Running pre-action listener: _resource_record_pre_action 01:21:22 INFO - Running main action method: read_buildbot_config 01:21:22 INFO - Using buildbot properties: 01:21:22 INFO - { 01:21:22 INFO - "project": "", 01:21:22 INFO - "product": "firefox", 01:21:22 INFO - "script_repo_revision": "production", 01:21:22 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 01:21:22 INFO - "repository": "", 01:21:22 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 01:21:22 INFO - "buildid": "20160210223010", 01:21:22 INFO - "pgo_build": "True", 01:21:22 INFO - "basedir": "/builds/slave/test-pgo", 01:21:22 INFO - "buildnumber": 730, 01:21:22 INFO - "slavename": "talos-linux64-ix-035", 01:21:22 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:21:22 INFO - "platform": "ubuntu64_hw", 01:21:22 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 01:21:22 INFO - "branch": "mozilla-inbound", 01:21:22 INFO - "repo_path": "integration/mozilla-inbound", 01:21:22 INFO - "revision": "97c7a71cce023044f6c1bf84d8a3a0affa7cc219", 01:21:22 INFO - "stage_platform": "linux64-pgo", 01:21:22 INFO - "builduid": "b78084be8b85488db3a68438ffaf1b75", 01:21:22 INFO - "slavebuilddir": "test" 01:21:22 INFO - } 01:21:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/LvhqRS_gTwyvdV_RRmF29g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 01:21:22 INFO - Running post-action listener: _resource_record_post_action 01:21:22 INFO - ##### 01:21:22 INFO - ##### Running download-and-extract step. 01:21:22 INFO - ##### 01:21:22 INFO - Running pre-action listener: _resource_record_pre_action 01:21:22 INFO - Running main action method: download_and_extract 01:21:22 INFO - mkdir: /builds/slave/test-pgo/build/tests 01:21:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:21:22 INFO - https://queue.taskcluster.net/v1/task/LvhqRS_gTwyvdV_RRmF29g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 01:21:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LvhqRS_gTwyvdV_RRmF29g/artifacts/public/build/test_packages.json 01:21:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LvhqRS_gTwyvdV_RRmF29g/artifacts/public/build/test_packages.json 01:21:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LvhqRS_gTwyvdV_RRmF29g/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 01:21:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LvhqRS_gTwyvdV_RRmF29g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 01:21:25 INFO - Downloaded 1448 bytes. 01:21:25 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 01:21:25 INFO - Using the following test package requirements: 01:21:25 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 01:21:25 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 01:21:25 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:21:25 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 01:21:25 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:21:25 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 01:21:25 INFO - u'jsshell-linux-x86_64.zip'], 01:21:25 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 01:21:25 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:21:25 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 01:21:25 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 01:21:25 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:21:25 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 01:21:25 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:21:25 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 01:21:25 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:21:25 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 01:21:25 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 01:21:25 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:21:25 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:21:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:21:25 INFO - https://queue.taskcluster.net/v1/task/LvhqRS_gTwyvdV_RRmF29g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:21:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LvhqRS_gTwyvdV_RRmF29g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 01:21:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LvhqRS_gTwyvdV_RRmF29g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 01:21:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LvhqRS_gTwyvdV_RRmF29g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 01:21:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LvhqRS_gTwyvdV_RRmF29g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:21:31 INFO - Downloaded 23297288 bytes. 01:21:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 01:21:31 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 01:21:32 INFO - Return code: 0 01:21:32 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:21: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')]} 01:21:32 INFO - https://queue.taskcluster.net/v1/task/LvhqRS_gTwyvdV_RRmF29g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:21:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LvhqRS_gTwyvdV_RRmF29g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 01:21:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LvhqRS_gTwyvdV_RRmF29g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 01:21:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LvhqRS_gTwyvdV_RRmF29g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 01:21:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LvhqRS_gTwyvdV_RRmF29g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:21:34 INFO - Downloaded 23297288 bytes. 01:21:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 01:21:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 01:21:35 INFO - Return code: 0 01:21: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')]} 01:21:35 INFO - https://queue.taskcluster.net/v1/task/LvhqRS_gTwyvdV_RRmF29g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:21:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LvhqRS_gTwyvdV_RRmF29g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 01:21:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LvhqRS_gTwyvdV_RRmF29g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 01:21:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LvhqRS_gTwyvdV_RRmF29g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 01:21:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LvhqRS_gTwyvdV_RRmF29g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:21:37 INFO - Downloaded 10706547 bytes. 01:21:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 01:21:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 01:21:37 INFO - Return code: 0 01:21:37 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')]} 01:21:37 INFO - https://queue.taskcluster.net/v1/task/LvhqRS_gTwyvdV_RRmF29g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:21:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LvhqRS_gTwyvdV_RRmF29g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 01:21:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LvhqRS_gTwyvdV_RRmF29g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 01:21:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LvhqRS_gTwyvdV_RRmF29g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 01:21:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LvhqRS_gTwyvdV_RRmF29g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:21:40 INFO - Downloaded 56572483 bytes. 01:21:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LvhqRS_gTwyvdV_RRmF29g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 01:21:40 INFO - mkdir: /builds/slave/test-pgo/properties 01:21:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 01:21:40 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 01:21:40 INFO - Contents: 01:21:40 INFO - build_url:https://queue.taskcluster.net/v1/task/LvhqRS_gTwyvdV_RRmF29g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 01:21:41 INFO - Running post-action listener: _resource_record_post_action 01:21:41 INFO - Running post-action listener: set_extra_try_arguments 01:21:41 INFO - ##### 01:21:41 INFO - ##### Running populate-webroot step. 01:21:41 INFO - ##### 01:21:41 INFO - Running pre-action listener: _resource_record_pre_action 01:21:41 INFO - Running main action method: populate_webroot 01:21:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:21:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:21:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:21:41 INFO - '--tppagecycles', 01:21:41 INFO - '7'], 01:21:41 INFO - 'tests': ['tsvgm']}}, 01:21:41 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:21:41 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:21:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:21:41 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 01:21:41 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:21:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:21:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:21:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:21:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:21:41 INFO - 'talos_options': ['--e10s'], 01:21:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:21:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:21:41 INFO - 'tests': ['damp', 'tps']}, 01:21:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:21:41 INFO - 'talos_options': ['--e10s'], 01:21:41 INFO - 'tests': ['damp', 'tps']}, 01:21:41 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:21:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:21:41 INFO - 'other': {'tests': ['a11yr', 01:21:41 INFO - 'ts_paint', 01:21:41 INFO - 'tpaint', 01:21:41 INFO - 'sessionrestore', 01:21:41 INFO - 'sessionrestore_no_auto_restore']}, 01:21:41 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:21:41 INFO - 'tests': ['a11yr', 01:21:41 INFO - 'ts_paint', 01:21:41 INFO - 'tpaint', 01:21:41 INFO - 'sessionrestore', 01:21:41 INFO - 'sessionrestore_no_auto_restore']}, 01:21:41 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:21:41 INFO - 'tests': ['a11yr', 01:21:41 INFO - 'ts_paint', 01:21:41 INFO - 'tpaint', 01:21:41 INFO - 'sessionrestore', 01:21:41 INFO - 'sessionrestore_no_auto_restore']}, 01:21:41 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:21:41 INFO - 'tests': ['a11yr', 01:21:41 INFO - 'ts_paint', 01:21:41 INFO - 'tpaint', 01:21:41 INFO - 'sessionrestore', 01:21:41 INFO - 'sessionrestore_no_auto_restore']}, 01:21:41 INFO - 'other_l64': {'tests': ['a11yr', 01:21:41 INFO - 'ts_paint', 01:21:41 INFO - 'tpaint', 01:21:41 INFO - 'sessionrestore', 01:21:41 INFO - 'sessionrestore_no_auto_restore']}, 01:21:41 INFO - 'other_nol64': {'tests': ['a11yr', 01:21:41 INFO - 'ts_paint', 01:21:41 INFO - 'tpaint', 01:21:41 INFO - 'sessionrestore', 01:21:41 INFO - 'sessionrestore_no_auto_restore']}, 01:21:41 INFO - 'svgr': {'tests': ['tsvgx', 01:21:41 INFO - 'tsvgr_opacity', 01:21:41 INFO - 'tart', 01:21:41 INFO - 'tscrollx', 01:21:41 INFO - 'cart']}, 01:21:41 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:21:41 INFO - 'tests': ['tsvgx', 01:21:41 INFO - 'tsvgr_opacity', 01:21:41 INFO - 'tart', 01:21:41 INFO - 'tscrollx', 01:21:41 INFO - 'cart']}, 01:21:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:21:41 INFO - 'tests': ['tp5o']}, 01:21:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:21:41 INFO - 'talos_options': ['--e10s'], 01:21:41 INFO - 'tests': ['tp5o']}, 01:21:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:21:41 INFO - 'talos_options': ['--xperf_path', 01:21:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:21:41 INFO - 'tests': ['tp5n']}, 01:21:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:21:41 INFO - 'talos_options': ['--e10s', 01:21:41 INFO - '--xperf_path', 01:21:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:21:41 INFO - 'tests': ['tp5n']}}, 01:21:41 INFO - 'talos.zip': {'path': '', 01:21:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:21:41 INFO - Running post-action listener: _resource_record_post_action 01:21:41 INFO - ##### 01:21:41 INFO - ##### Running create-virtualenv step. 01:21:41 INFO - ##### 01:21:41 INFO - Running pre-action listener: _resource_record_pre_action 01:21:41 INFO - Running main action method: create_virtualenv 01:21:41 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 01:21:41 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 01:21:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 01:21:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:21:41 INFO - Using real prefix '/usr' 01:21:41 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 01:21:42 INFO - Installing distribute.............................................................................................................................................................................................done. 01:21:44 INFO - Installing pip.................done. 01:21:44 INFO - Return code: 0 01:21:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 01:21:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:21:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:21:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:21:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:21:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:44 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 0x7fc9faa62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11da670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12698c0>, '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 0x126a7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126ac50>, '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': 'ed14279e38b05397cf4aa391000001a4-1455181951.930554-820759853', '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 01:21:44 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 01:21:44 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 01:21:44 INFO - Using env: {'DISPLAY': ':0', 01:21:44 INFO - 'HOME': '/home/cltbld', 01:21:44 INFO - 'LANG': 'en_US.UTF-8', 01:21:44 INFO - 'LANGUAGE': 'en_US:en', 01:21:44 INFO - 'LOGNAME': 'cltbld', 01:21:44 INFO - 'MAIL': '/var/mail/cltbld', 01:21:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:21:44 INFO - 'MOZ_NO_REMOTE': '1', 01:21:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:21:44 INFO - 'NO_EM_RESTART': '1', 01:21:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:21:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:21:44 INFO - 'PWD': '/builds/slave/test-pgo', 01:21:44 INFO - 'SHELL': '/bin/bash', 01:21:44 INFO - 'SHLVL': '1', 01:21:44 INFO - 'TERM': 'linux', 01:21:44 INFO - 'TMOUT': '86400', 01:21:44 INFO - 'USER': 'cltbld', 01:21:44 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1455181951.930554-820759853', 01:21:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:21:44 INFO - '_': '/tools/buildbot/bin/python'} 01:21:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:21:44 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 01:21:44 INFO - Cleaning up... 01:21:44 INFO - Return code: 0 01:21:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 01:21:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:21:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:21:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:21:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:21:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:44 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 0x7fc9faa62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11da670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12698c0>, '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 0x126a7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126ac50>, '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': 'ed14279e38b05397cf4aa391000001a4-1455181951.930554-820759853', '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 01:21:44 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 01:21:44 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 01:21:44 INFO - Using env: {'DISPLAY': ':0', 01:21:44 INFO - 'HOME': '/home/cltbld', 01:21:44 INFO - 'LANG': 'en_US.UTF-8', 01:21:44 INFO - 'LANGUAGE': 'en_US:en', 01:21:44 INFO - 'LOGNAME': 'cltbld', 01:21:44 INFO - 'MAIL': '/var/mail/cltbld', 01:21:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:21:44 INFO - 'MOZ_NO_REMOTE': '1', 01:21:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:21:44 INFO - 'NO_EM_RESTART': '1', 01:21:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:21:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:21:44 INFO - 'PWD': '/builds/slave/test-pgo', 01:21:44 INFO - 'SHELL': '/bin/bash', 01:21:44 INFO - 'SHLVL': '1', 01:21:44 INFO - 'TERM': 'linux', 01:21:44 INFO - 'TMOUT': '86400', 01:21:44 INFO - 'USER': 'cltbld', 01:21:44 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1455181951.930554-820759853', 01:21:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:21:44 INFO - '_': '/tools/buildbot/bin/python'} 01:21:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:21:44 INFO - Downloading/unpacking psutil>=0.7.1 01:21:44 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 01:21:44 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 01:21:44 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 01:21:44 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 01:21:44 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 01:21:44 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 01:21:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 01:21:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:21:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:21:46 INFO - Installing collected packages: psutil 01:21:46 INFO - Running setup.py install for psutil 01:21:47 INFO - building 'psutil._psutil_linux' extension 01:21:47 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 01:21:47 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 01:21:47 INFO - building 'psutil._psutil_posix' extension 01:21:47 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 01:21:47 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 01:21:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:21:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:21:47 INFO - Successfully installed psutil 01:21:47 INFO - Cleaning up... 01:21:48 INFO - Return code: 0 01:21:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 01:21: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')]} 01:21:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:21:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21: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')]} 01:21:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:21:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21: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', '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 0x7fc9faa62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11da670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12698c0>, '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 0x126a7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126ac50>, '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': 'ed14279e38b05397cf4aa391000001a4-1455181951.930554-820759853', '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 01:21: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 01:21: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 mozsystemmonitor==0.0.0 01:21:48 INFO - Using env: {'DISPLAY': ':0', 01:21:48 INFO - 'HOME': '/home/cltbld', 01:21:48 INFO - 'LANG': 'en_US.UTF-8', 01:21:48 INFO - 'LANGUAGE': 'en_US:en', 01:21:48 INFO - 'LOGNAME': 'cltbld', 01:21:48 INFO - 'MAIL': '/var/mail/cltbld', 01:21:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:21:48 INFO - 'MOZ_NO_REMOTE': '1', 01:21:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:21:48 INFO - 'NO_EM_RESTART': '1', 01:21:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:21:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:21:48 INFO - 'PWD': '/builds/slave/test-pgo', 01:21:48 INFO - 'SHELL': '/bin/bash', 01:21:48 INFO - 'SHLVL': '1', 01:21:48 INFO - 'TERM': 'linux', 01:21:48 INFO - 'TMOUT': '86400', 01:21:48 INFO - 'USER': 'cltbld', 01:21:48 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1455181951.930554-820759853', 01:21:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:21:48 INFO - '_': '/tools/buildbot/bin/python'} 01:21:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:21:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:21: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 01:21: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 01:21: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 01:21: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 01:21: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 01:21: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 01:21:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:21:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:21:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:21:50 INFO - Installing collected packages: mozsystemmonitor 01:21:50 INFO - Running setup.py install for mozsystemmonitor 01:21:50 INFO - Successfully installed mozsystemmonitor 01:21:50 INFO - Cleaning up... 01:21:50 INFO - Return code: 0 01:21:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 01:21:50 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')]} 01:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:21:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:50 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')]} 01:21:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:21:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:50 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 0x7fc9faa62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11da670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12698c0>, '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 0x126a7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126ac50>, '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': 'ed14279e38b05397cf4aa391000001a4-1455181951.930554-820759853', '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 01:21:50 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 01:21:50 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 01:21:50 INFO - Using env: {'DISPLAY': ':0', 01:21:50 INFO - 'HOME': '/home/cltbld', 01:21:50 INFO - 'LANG': 'en_US.UTF-8', 01:21:50 INFO - 'LANGUAGE': 'en_US:en', 01:21:50 INFO - 'LOGNAME': 'cltbld', 01:21:50 INFO - 'MAIL': '/var/mail/cltbld', 01:21:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:21:50 INFO - 'MOZ_NO_REMOTE': '1', 01:21:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:21:50 INFO - 'NO_EM_RESTART': '1', 01:21:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:21:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:21:50 INFO - 'PWD': '/builds/slave/test-pgo', 01:21:50 INFO - 'SHELL': '/bin/bash', 01:21:50 INFO - 'SHLVL': '1', 01:21:50 INFO - 'TERM': 'linux', 01:21:50 INFO - 'TMOUT': '86400', 01:21:50 INFO - 'USER': 'cltbld', 01:21:50 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1455181951.930554-820759853', 01:21:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:21:50 INFO - '_': '/tools/buildbot/bin/python'} 01:21:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:21:50 INFO - Downloading/unpacking blobuploader==1.2.4 01:21: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 01:21: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 01:21: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 01:21: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 01:21: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 01:21: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 01:21:52 INFO - Downloading blobuploader-1.2.4.tar.gz 01:21:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:21:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:21:52 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 01:21:52 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 01:21:52 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 01:21:52 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 01:21:52 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 01:21:52 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 01:21:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 01:21:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:21:52 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 01:21:52 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 01:21:52 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 01:21:52 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 01:21:52 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 01:21:52 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 01:21:52 INFO - Downloading docopt-0.6.1.tar.gz 01:21:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 01:21:53 INFO - Installing collected packages: blobuploader, requests, docopt 01:21:53 INFO - Running setup.py install for blobuploader 01:21:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:21:53 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 01:21:53 INFO - Running setup.py install for requests 01:21:53 INFO - Running setup.py install for docopt 01:21:53 INFO - Successfully installed blobuploader requests docopt 01:21:53 INFO - Cleaning up... 01:21:53 INFO - Return code: 0 01:21:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:21:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:21:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:21:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:21:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:21:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:53 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 0x7fc9faa62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11da670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12698c0>, '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 0x126a7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126ac50>, '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': 'ed14279e38b05397cf4aa391000001a4-1455181951.930554-820759853', '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 01:21:53 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 01:21:53 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 01:21:53 INFO - Using env: {'DISPLAY': ':0', 01:21:53 INFO - 'HOME': '/home/cltbld', 01:21:53 INFO - 'LANG': 'en_US.UTF-8', 01:21:53 INFO - 'LANGUAGE': 'en_US:en', 01:21:53 INFO - 'LOGNAME': 'cltbld', 01:21:53 INFO - 'MAIL': '/var/mail/cltbld', 01:21:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:21:53 INFO - 'MOZ_NO_REMOTE': '1', 01:21:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:21:53 INFO - 'NO_EM_RESTART': '1', 01:21:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:21:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:21:53 INFO - 'PWD': '/builds/slave/test-pgo', 01:21:53 INFO - 'SHELL': '/bin/bash', 01:21:53 INFO - 'SHLVL': '1', 01:21:53 INFO - 'TERM': 'linux', 01:21:53 INFO - 'TMOUT': '86400', 01:21:53 INFO - 'USER': 'cltbld', 01:21:53 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1455181951.930554-820759853', 01:21:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:21:53 INFO - '_': '/tools/buildbot/bin/python'} 01:21:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:21:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:21:53 INFO - Running setup.py (path:/tmp/pip-SnMh7o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:21:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:21:53 INFO - Running setup.py (path:/tmp/pip-Ao_z3v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:21:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:21:53 INFO - Running setup.py (path:/tmp/pip-sPsDXs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:21:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:21:54 INFO - Running setup.py (path:/tmp/pip-mbYXVC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:21:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:21:54 INFO - Running setup.py (path:/tmp/pip-q4fW_b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:21:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:21:54 INFO - Running setup.py (path:/tmp/pip-VAMUTv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:21:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:21:54 INFO - Running setup.py (path:/tmp/pip-1mrQbE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:21:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:21:54 INFO - Running setup.py (path:/tmp/pip-TX6cum-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:21:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:21:54 INFO - Running setup.py (path:/tmp/pip-wHO6if-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:21:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:21:54 INFO - Running setup.py (path:/tmp/pip-lQutQS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:21:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:21:54 INFO - Running setup.py (path:/tmp/pip-Nggeyt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:21:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:21:54 INFO - Running setup.py (path:/tmp/pip-vxv8s8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:21:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:21:54 INFO - Running setup.py (path:/tmp/pip-tche2g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:21:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:21:54 INFO - Running setup.py (path:/tmp/pip-iLXzOD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:21:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:21:54 INFO - Running setup.py (path:/tmp/pip-VIuu2b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:21:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:21:54 INFO - Running setup.py (path:/tmp/pip-FD4HbO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:21:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:21:54 INFO - Running setup.py (path:/tmp/pip-kfXU9M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:21:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:21:55 INFO - Running setup.py install for manifestparser 01:21:55 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 01:21:55 INFO - Running setup.py install for mozcrash 01:21:55 INFO - Running setup.py install for mozdebug 01:21:55 INFO - Running setup.py install for mozdevice 01:21:55 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 01:21:55 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 01:21:55 INFO - Running setup.py install for mozfile 01:21:55 INFO - Running setup.py install for mozhttpd 01:21:55 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 01:21:55 INFO - Running setup.py install for mozinfo 01:21:55 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 01:21:55 INFO - Running setup.py install for mozInstall 01:21:55 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 01:21:55 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 01:21:55 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 01:21:55 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 01:21:55 INFO - Running setup.py install for mozleak 01:21:55 INFO - Running setup.py install for mozlog 01:21:56 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 01:21:56 INFO - Running setup.py install for moznetwork 01:21:56 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 01:21:56 INFO - Running setup.py install for mozprocess 01:21:56 INFO - Running setup.py install for mozprofile 01:21:56 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 01:21:56 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 01:21:56 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 01:21:56 INFO - Running setup.py install for mozrunner 01:21:56 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 01:21:56 INFO - Running setup.py install for mozscreenshot 01:21:56 INFO - Running setup.py install for moztest 01:21:56 INFO - Running setup.py install for mozversion 01:21:56 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 01:21:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:21:56 INFO - Cleaning up... 01:21:56 INFO - Return code: 0 01:21:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:21:56 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')]} 01:21:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:21:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:56 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')]} 01:21:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:21:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:56 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 0x7fc9faa62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11da670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12698c0>, '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 0x126a7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126ac50>, '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': 'ed14279e38b05397cf4aa391000001a4-1455181951.930554-820759853', '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 01:21:56 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 01:21:56 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 01:21:56 INFO - Using env: {'DISPLAY': ':0', 01:21:56 INFO - 'HOME': '/home/cltbld', 01:21:56 INFO - 'LANG': 'en_US.UTF-8', 01:21:56 INFO - 'LANGUAGE': 'en_US:en', 01:21:56 INFO - 'LOGNAME': 'cltbld', 01:21:56 INFO - 'MAIL': '/var/mail/cltbld', 01:21:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:21:56 INFO - 'MOZ_NO_REMOTE': '1', 01:21:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:21:56 INFO - 'NO_EM_RESTART': '1', 01:21:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:21:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:21:56 INFO - 'PWD': '/builds/slave/test-pgo', 01:21:56 INFO - 'SHELL': '/bin/bash', 01:21:56 INFO - 'SHLVL': '1', 01:21:56 INFO - 'TERM': 'linux', 01:21:56 INFO - 'TMOUT': '86400', 01:21:56 INFO - 'USER': 'cltbld', 01:21:56 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1455181951.930554-820759853', 01:21:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:21:56 INFO - '_': '/tools/buildbot/bin/python'} 01:21:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:21:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:21:57 INFO - Running setup.py (path:/tmp/pip-jJTGrM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:21:57 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)) 01:21:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:21:57 INFO - Running setup.py (path:/tmp/pip-bMKxJ8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:21:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 01:21:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:21:57 INFO - Running setup.py (path:/tmp/pip-7bsffP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:21:57 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)) 01:21:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:21:57 INFO - Running setup.py (path:/tmp/pip-c_e_H8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:21:57 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)) 01:21:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:21:57 INFO - Running setup.py (path:/tmp/pip-waPvKo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:21:57 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)) 01:21:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:21:57 INFO - Running setup.py (path:/tmp/pip-sk6Tfr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:21:57 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)) 01:21:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:21:57 INFO - Running setup.py (path:/tmp/pip-3GqNhg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:21:57 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)) 01:21:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:21:57 INFO - Running setup.py (path:/tmp/pip-Aa3Pm7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:21:57 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)) 01:21:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:21:57 INFO - Running setup.py (path:/tmp/pip-mNYfzR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:21:57 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)) 01:21:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:21:57 INFO - Running setup.py (path:/tmp/pip-TIb1aA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:21:57 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)) 01:21:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:21:57 INFO - Running setup.py (path:/tmp/pip-a9XASU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:21:57 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)) 01:21:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:21:57 INFO - Running setup.py (path:/tmp/pip-U8s4P_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:21:57 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)) 01:21:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:21:57 INFO - Running setup.py (path:/tmp/pip-0WZvzx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:21:57 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)) 01:21:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:21:57 INFO - Running setup.py (path:/tmp/pip-0pNvtA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:21:58 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)) 01:21:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:21:58 INFO - Running setup.py (path:/tmp/pip-BsYIy9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:21:58 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)) 01:21:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:21:58 INFO - Running setup.py (path:/tmp/pip-GwrUaC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:21:58 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)) 01:21:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:21:58 INFO - Running setup.py (path:/tmp/pip-L381M5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:21:58 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)) 01:21:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 01:21:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 01:21:58 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)) 01:21:58 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)) 01:21:58 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)) 01:21:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 01:21:58 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 01:21:58 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 01:21:58 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 01:21:58 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 01:21:58 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 01:21:58 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 01:22:00 INFO - Downloading blessings-1.6.tar.gz 01:22:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 01:22:00 INFO - Installing collected packages: blessings 01:22:00 INFO - Running setup.py install for blessings 01:22:00 INFO - Successfully installed blessings 01:22:00 INFO - Cleaning up... 01:22:00 INFO - Return code: 0 01:22:00 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 01:22:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:22:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:22:00 INFO - Reading from file tmpfile_stdout 01:22:00 INFO - Current package versions: 01:22:00 INFO - argparse == 1.2.1 01:22:00 INFO - blessings == 1.6 01:22:00 INFO - blobuploader == 1.2.4 01:22:00 INFO - docopt == 0.6.1 01:22:00 INFO - manifestparser == 1.1 01:22:00 INFO - mozInstall == 1.12 01:22:00 INFO - mozcrash == 0.16 01:22:00 INFO - mozdebug == 0.1 01:22:00 INFO - mozdevice == 0.48 01:22:00 INFO - mozfile == 1.2 01:22:00 INFO - mozhttpd == 0.7 01:22:00 INFO - mozinfo == 0.9 01:22:00 INFO - mozleak == 0.1 01:22:00 INFO - mozlog == 3.1 01:22:00 INFO - moznetwork == 0.27 01:22:00 INFO - mozprocess == 0.22 01:22:00 INFO - mozprofile == 0.28 01:22:00 INFO - mozrunner == 6.11 01:22:00 INFO - mozscreenshot == 0.1 01:22:00 INFO - mozsystemmonitor == 0.0 01:22:00 INFO - moztest == 0.7 01:22:00 INFO - mozversion == 1.4 01:22:00 INFO - psutil == 3.1.1 01:22:00 INFO - requests == 1.2.3 01:22:00 INFO - wsgiref == 0.1.2 01:22:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:22:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:22:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:22:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:22:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:22:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:22:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:22:00 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 0x7fc9faa62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11da670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12698c0>, '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 0x126a7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126ac50>, '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': 'ed14279e38b05397cf4aa391000001a4-1455181951.930554-820759853', '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 01:22:00 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 01:22:00 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 01:22:00 INFO - Using env: {'DISPLAY': ':0', 01:22:00 INFO - 'HOME': '/home/cltbld', 01:22:00 INFO - 'LANG': 'en_US.UTF-8', 01:22:00 INFO - 'LANGUAGE': 'en_US:en', 01:22:00 INFO - 'LOGNAME': 'cltbld', 01:22:00 INFO - 'MAIL': '/var/mail/cltbld', 01:22:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:22:00 INFO - 'MOZ_NO_REMOTE': '1', 01:22:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:22:00 INFO - 'NO_EM_RESTART': '1', 01:22:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:22:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:22:00 INFO - 'PWD': '/builds/slave/test-pgo', 01:22:00 INFO - 'SHELL': '/bin/bash', 01:22:00 INFO - 'SHLVL': '1', 01:22:00 INFO - 'TERM': 'linux', 01:22:00 INFO - 'TMOUT': '86400', 01:22:00 INFO - 'USER': 'cltbld', 01:22:00 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1455181951.930554-820759853', 01:22:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:22:00 INFO - '_': '/tools/buildbot/bin/python'} 01:22:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:22:00 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)) 01:22:00 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)) 01:22:00 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)) 01:22:00 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)) 01:22:00 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)) 01:22:00 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)) 01:22:00 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)) 01:22:00 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)) 01:22:00 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)) 01:22:00 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)) 01:22:00 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)) 01:22:00 INFO - Cleaning up... 01:22:00 INFO - Return code: 0 01:22:00 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 01:22:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:22:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:22:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:22:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:22:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:22:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:22:00 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 0x7fc9faa62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11da670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12698c0>, '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 0x126a7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126ac50>, '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': 'ed14279e38b05397cf4aa391000001a4-1455181951.930554-820759853', '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 01:22:00 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 01:22:00 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 01:22:00 INFO - Using env: {'DISPLAY': ':0', 01:22:00 INFO - 'HOME': '/home/cltbld', 01:22:00 INFO - 'LANG': 'en_US.UTF-8', 01:22:00 INFO - 'LANGUAGE': 'en_US:en', 01:22:00 INFO - 'LOGNAME': 'cltbld', 01:22:00 INFO - 'MAIL': '/var/mail/cltbld', 01:22:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:22:00 INFO - 'MOZ_NO_REMOTE': '1', 01:22:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:22:00 INFO - 'NO_EM_RESTART': '1', 01:22:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:22:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:22:00 INFO - 'PWD': '/builds/slave/test-pgo', 01:22:00 INFO - 'SHELL': '/bin/bash', 01:22:00 INFO - 'SHLVL': '1', 01:22:00 INFO - 'TERM': 'linux', 01:22:00 INFO - 'TMOUT': '86400', 01:22:00 INFO - 'USER': 'cltbld', 01:22:00 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1455181951.930554-820759853', 01:22:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:22:00 INFO - '_': '/tools/buildbot/bin/python'} 01:22:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:22:00 INFO - Downloading/unpacking jsonschema 01:22:00 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 01:22:00 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 01:22:00 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 01:22:00 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 01:22:00 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 01:22:00 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 01:22:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:22:02 INFO - Downloading/unpacking functools32 (from jsonschema) 01:22:02 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 01:22:02 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 01:22:02 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 01:22:02 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 01:22:02 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 01:22:02 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 01:22:02 INFO - Downloading functools32-3.2.3-2.tar.gz 01:22:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 01:22:02 INFO - warning: no files found matching '*.txt' 01:22:02 INFO - no previously-included directories found matching 'build' 01:22:02 INFO - no previously-included directories found matching 'dist' 01:22:02 INFO - no previously-included directories found matching '.git*' 01:22:03 INFO - Installing collected packages: jsonschema, functools32 01:22:03 INFO - Running setup.py install for functools32 01:22:03 INFO - warning: no files found matching '*.txt' 01:22:03 INFO - no previously-included directories found matching 'build' 01:22:03 INFO - no previously-included directories found matching 'dist' 01:22:03 INFO - no previously-included directories found matching '.git*' 01:22:03 INFO - Successfully installed jsonschema functools32 01:22:03 INFO - Cleaning up... 01:22:03 INFO - Return code: 0 01:22:03 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 01:22:03 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')]} 01:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:22:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:22:03 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')]} 01:22:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:22:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:22:03 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 0x7fc9faa62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11da670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12698c0>, '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 0x126a7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126ac50>, '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': 'ed14279e38b05397cf4aa391000001a4-1455181951.930554-820759853', '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 01:22:03 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 01:22:03 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 01:22:03 INFO - Using env: {'DISPLAY': ':0', 01:22:03 INFO - 'HOME': '/home/cltbld', 01:22:03 INFO - 'LANG': 'en_US.UTF-8', 01:22:03 INFO - 'LANGUAGE': 'en_US:en', 01:22:03 INFO - 'LOGNAME': 'cltbld', 01:22:03 INFO - 'MAIL': '/var/mail/cltbld', 01:22:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:22:03 INFO - 'MOZ_NO_REMOTE': '1', 01:22:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:22:03 INFO - 'NO_EM_RESTART': '1', 01:22:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:22:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:22:03 INFO - 'PWD': '/builds/slave/test-pgo', 01:22:03 INFO - 'SHELL': '/bin/bash', 01:22:03 INFO - 'SHLVL': '1', 01:22:03 INFO - 'TERM': 'linux', 01:22:03 INFO - 'TMOUT': '86400', 01:22:03 INFO - 'USER': 'cltbld', 01:22:03 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1455181951.930554-820759853', 01:22:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:22:03 INFO - '_': '/tools/buildbot/bin/python'} 01:22:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:22:03 INFO - Downloading/unpacking flake8 01:22:03 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 01:22:03 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 01:22:03 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 01:22:03 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 01:22:03 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 01:22:03 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 01:22:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:22:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:22:05 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 01:22:05 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 01:22:05 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 01:22:05 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 01:22:05 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 01:22:05 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 01:22:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:22:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:22:05 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 01:22:05 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 01:22:05 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 01:22:05 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 01:22:05 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 01:22:05 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 01:22:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:22:05 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 01:22:05 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 01:22:05 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 01:22:05 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 01:22:05 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 01:22:05 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 01:22:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 01:22:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:22:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:22:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:22:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:22:05 INFO - no previously-included directories found matching 'docs/_build' 01:22:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:22:05 INFO - Running setup.py install for pep8 01:22:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:22:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:22:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:22:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:22:06 INFO - no previously-included directories found matching 'docs/_build' 01:22:06 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 01:22:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:22:06 INFO - Cleaning up... 01:22:06 INFO - Return code: 0 01:22:06 INFO - Running post-action listener: _resource_record_post_action 01:22:06 INFO - Running post-action listener: _start_resource_monitoring 01:22:06 INFO - Starting resource monitoring. 01:22:06 INFO - ##### 01:22:06 INFO - ##### Running install step. 01:22:06 INFO - ##### 01:22:06 INFO - Running pre-action listener: _resource_record_pre_action 01:22:06 INFO - Running main action method: install 01:22:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:22:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:22:06 INFO - Reading from file tmpfile_stdout 01:22:06 INFO - Detecting whether we're running mozinstall >=1.0... 01:22:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 01:22:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 01:22:06 INFO - Reading from file tmpfile_stdout 01:22:06 INFO - Output received: 01:22:06 INFO - Usage: mozinstall [options] installer 01:22:06 INFO - Options: 01:22:06 INFO - -h, --help show this help message and exit 01:22:06 INFO - -d DEST, --destination=DEST 01:22:06 INFO - Directory to install application into. [default: 01:22:06 INFO - "/builds/slave/test-pgo"] 01:22:06 INFO - --app=APP Application being installed. [default: firefox] 01:22:06 INFO - mkdir: /builds/slave/test-pgo/build/application 01:22:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 01:22:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 01:22:22 INFO - Reading from file tmpfile_stdout 01:22:22 INFO - Output received: 01:22:22 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 01:22:22 INFO - Running post-action listener: _resource_record_post_action 01:22:22 INFO - ##### 01:22:22 INFO - ##### Running run-tests step. 01:22:22 INFO - ##### 01:22:22 INFO - Running pre-action listener: _resource_record_pre_action 01:22:22 INFO - Running main action method: run_tests 01:22:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 01:22:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 01:22:22 INFO - Python 2.7.3 01:22:22 INFO - Return code: 0 01:22:22 INFO - grabbing minidump binary from tooltool 01:22:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:22:22 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 0x12698c0>, '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 0x126a7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126ac50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 01:22:22 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 01:22:22 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 01:22:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:22:22 INFO - Return code: 0 01:22:22 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 01:22:22 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 01:22:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 01:22:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 01:22:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 01:22:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 01:22:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 01:22:23 INFO - Return code: 0 01:22:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LvhqRS_gTwyvdV_RRmF29g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 01:22:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LvhqRS_gTwyvdV_RRmF29g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --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 01:22:23 INFO - Using env: {'DISPLAY': ':0', 01:22:23 INFO - 'HOME': '/home/cltbld', 01:22:23 INFO - 'LANG': 'en_US.UTF-8', 01:22:23 INFO - 'LANGUAGE': 'en_US:en', 01:22:23 INFO - 'LOGNAME': 'cltbld', 01:22:23 INFO - 'MAIL': '/var/mail/cltbld', 01:22:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:22:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 01:22:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:22:23 INFO - 'MOZ_NO_REMOTE': '1', 01:22:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:22:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:22:23 INFO - 'NO_EM_RESTART': '1', 01:22:23 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:22:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:22:23 INFO - 'PWD': '/builds/slave/test-pgo', 01:22:23 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 01:22:23 INFO - 'SHELL': '/bin/bash', 01:22:23 INFO - 'SHLVL': '1', 01:22:23 INFO - 'TERM': 'linux', 01:22:23 INFO - 'TMOUT': '86400', 01:22:23 INFO - 'USER': 'cltbld', 01:22:23 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1455181951.930554-820759853', 01:22:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:22:23 INFO - '_': '/tools/buildbot/bin/python'} 01:22:23 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LvhqRS_gTwyvdV_RRmF29g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 01:22:23 INFO - mozversion application_buildid: 20160210223010 01:22:23 INFO - mozversion application_changeset: 97c7a71cce023044f6c1bf84d8a3a0affa7cc219 01:22:23 INFO - mozversion application_display_name: Nightly 01:22:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:22:23 INFO - mozversion application_name: Firefox 01:22:23 INFO - mozversion application_remotingname: firefox 01:22:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:22:23 INFO - mozversion application_vendor: Mozilla 01:22:23 INFO - mozversion application_version: 47.0a1 01:22:23 INFO - mozversion platform_buildid: 20160210223010 01:22:23 INFO - mozversion platform_changeset: 97c7a71cce023044f6c1bf84d8a3a0affa7cc219 01:22:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:22:23 INFO - mozversion platform_version: 47.0a1 01:22:23 INFO - using testdate: 1455182543 01:22:23 INFO - actual date: 1455182543 01:22:24 INFO - starting webserver on 'localhost:44501' 01:22:24 INFO - SUITE-START | Running 2 tests 01:22:24 INFO - TEST-START | dromaeo_css 01:22:24 INFO - operating with platform_type : linux_ 01:22:24 INFO - Initialising browser for dromaeo_css test... 01:22:24 INFO - TEST-INFO | started process 9048 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpto6npQ/profile http://localhost:44501/getInfo.html) 01:22:28 INFO - PROCESS | 9048 | __metrics Screen width/height:1600/1200 01:22:28 INFO - PROCESS | 9048 | colorDepth:24 01:22:28 INFO - PROCESS | 9048 | Browser inner width/height: 1024/697 01:22:28 INFO - PROCESS | 9048 | __metrics 01:22:28 INFO - PROCESS | 9048 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:22:28 INFO - TEST-INFO | 9048: exit 0 01:22:28 INFO - Browser initialized. 01:22:28 INFO - Running cycle 1/1 for dromaeo_css test... 01:22:29 INFO - TEST-INFO | started process 9137 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpto6npQ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:22:40 INFO - PROCESS | 9137 | RSS: Main: 153092096 01:22:40 INFO - PROCESS | 9137 | 01:23:31 INFO - PROCESS | 9137 | 1455182611559 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] 01:25:40 INFO - PROCESS | 9137 | Cycle 1(1): loaded http://localhost:44501/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44501/tests/dromaeo/cssquery-ext.html) 01:25:41 INFO - PROCESS | 9137 | RSS: Main: 234926080 01:25:41 INFO - PROCESS | 9137 | 01:28:44 INFO - PROCESS | 9137 | Cycle 1(1): loaded http://localhost:44501/tests/dromaeo/cssquery-ext.html (next: http://localhost:44501/tests/dromaeo/cssquery-jquery.html) 01:28:44 INFO - PROCESS | 9137 | RSS: Main: 239341568 01:28:44 INFO - PROCESS | 9137 | 01:31:46 INFO - PROCESS | 9137 | Cycle 1(1): loaded http://localhost:44501/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44501/tests/dromaeo/cssquery-mootools.html) 01:31:47 INFO - PROCESS | 9137 | RSS: Main: 244105216 01:31:47 INFO - PROCESS | 9137 | 01:34:49 INFO - PROCESS | 9137 | Cycle 1(1): loaded http://localhost:44501/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44501/tests/dromaeo/cssquery-prototype.html) 01:34:49 INFO - PROCESS | 9137 | RSS: Main: 219312128 01:34:49 INFO - PROCESS | 9137 | 01:37:52 INFO - PROCESS | 9137 | Cycle 1(1): loaded http://localhost:44501/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44501/tests/dromaeo/cssquery-yui.html) 01:37:53 INFO - PROCESS | 9137 | RSS: Main: 221081600 01:37:53 INFO - PROCESS | 9137 | 01:40:55 INFO - PROCESS | 9137 | Cycle 1(1): loaded http://localhost:44501/tests/dromaeo/cssquery-yui.html (next: http://localhost:44501/tests/dromaeo/cssquery-dojo.html) 01:40:56 INFO - PROCESS | 9137 | RSS: Main: 276623360 01:40:56 INFO - PROCESS | 9137 | 01:40:56 INFO - PROCESS | 9137 | __start_tp_report 01:40:56 INFO - PROCESS | 9137 | _x_x_mozilla_page_load 01:40:56 INFO - PROCESS | 9137 | _x_x_mozilla_page_load_details 01:40:56 INFO - PROCESS | 9137 | |i|pagename|runs| 01:40:56 INFO - PROCESS | 9137 | |0;dojo.html;3127.343257915838;3189.075168201222;3224.6130464344283;3226.080567038393;3259.902202933913;5063.0380227756705;5129.2306154076905;5178.326817513718;5192.92210616841;5211.035958347704;5132.871678208037;5179.922301165486;5212.8696782580455;5221.71280579568;5314.893702125955;4727.55088266615;4752.07334569759;4765.3328534005095;4778.450478195017;4924.261360795874;4834.3473631059705;4834.830780922668;4868.05073010763;4889.559939605435;4900.117978763821;4670.532946705336;4677.859664210079;4752.382190315271;4755.358026666408;4760.071786001731;4768.451628062782;4770.642201834877;4790.784414701312;4818.084563932842;4839.7338146401935;4721.220998535237;4765.451973023112;4771.737554434505;4773.3078703588135;4819.783109760069;5004.9749751251375;5079.74601269935;5087.694738315713;5087.720175390352;5107.233914912756;5554.416786237427;5557.916631250535;5558.749856256438;5559.58303127263;5574.414686457904;5570.888582228333;5577.386487486373;5584;5587.469190426903;5601.719914004283;5062.2406639004075;5132.461091585367;5231.843044708627;5234.869128271824;5314.867128321823;5607.579431542651;5614.859628509238;5619.971900140473;5642.351129620064;5644.520215781622;5406.837794866082;5416.647917885325;5418.187271909166;5422.024035673538;5430.484104010113;5546.084895992116;5591.4688104629995;5629.859253518613;5634.4365563443325;5664.915026274609;5550.777968881281;5554.2779438672715;5562.165675148679;5566.276384070126;5572.3034620672415;5523.502884740393;5553.08374118266;5557.249771280906;5557.472040156179;5560.777568897199;4209.3896385024;4257.531671516131;4296;4302.720323178984;4304.763238021939;3858.7105967052585;3870.3420418528917;3870.3613903705573;3907.0623050467684;3910.4916360872903;5068.341115655015;5133.922991155136;5144;5149.871253218699;5187.688738675692;5498.422665620133;5510.897820435849;5513.862153446196;5544.0575102232715;5569.66582005081;5099.056674515226;5115.590752739772;5117.462666420047;5120.948790512121;5162.819301324435;4638.234691275969;4679.438467383936;4747.762611869462;4750.049990002013;4752.405949256343;5729.684867332254;5768.105943578752;5784.074548072373;5787.102999035156;5843.386444423274;5486.807961721321;5522.337319521683;5530.695811730394;5531.115021596525;5531.612787104864;5589.832305030855;5700.657960522382;5712.571557133148;5714.3999880012;5736.340320862987;5475.917861232005;5476.014317422742;5482.150266708666;5487.122060470306;5533.6956467393065;5543.695096769555;5545.556355491632;5546.639468434539;5555.388907220284;5605.1872478491205;5353.598480113929;5379.569634429315;5410.75651595687;5440.782368705366;5466.753996070266;5461.15352120422;5465.480779325958;5467.972660136674;5468.8085916994305;5481.205225242238;5338.279332290091;5379.623426360117;5388.137897936312;5388.2725832012175;5436.565074793928;5334.3865455473115;5395.568354531707;5492.148716948879;5533.7786488541615;5539.972300138474;5298.337707786527;5298.920516192337;5341.4925582069645;5346.198070289488;5383.327084114486 01:40:56 INFO - PROCESS | 9137 | |1;ext.html;533.5224973648582;559.42099926576;567.163433934946;597.7907732293696;604.8729766748983;27984.160475185752;35463.645363546355;35841.46237806435;35948.64051359486;35965.10087247817;39424.21151576967;39582.406263906065;39793.00517487064;39881.40177897334;39960.60039399612;8465.830683386313;8654.177853103945;8674.783130421727;8684.435511691752;8684.56577171142;8364.749057528254;8495.447795893248;8501.06488286288;8509.74470765878;8705.129487051308;8691.826163476726;8783.516906570136;8792.560371981408;8792.69225577105;8796.296296296314;8618.741437756877;8670.913290867074;8680.56597170139;8682.30541556674;8700.34747393948;8681.131886811332;8823.823523529494;8825.249853762438;8832.646694132227;8839.602217900145;39370.21259574792;39726.40410393846;39844;39894;39934;3501.9824900875587;3520.1903562180587;3544.627814079536;3615.475756015363;3661.8535258589623;25920.534210434762;26397.73602263972;26558.867205664043;26560.86719566409;26611.600825987625;3714.684251838597;3718.244344610998;3730.403135498307;3794.9810250948567;3853.3064048471265;253115.73442132855;254010;254570;254795;255224;52514;53366.73316633392;58348.70825645845;60377;61067.11463082943;52585.211221831705;52754.472455275725;52787;52933.7353313231;52988.73505632447;14498.492552760603;14688;14689.265536723122;14741.336639851232;14748.188849613374;10563.841542376871;11677.065834733201;11810.586629467927;11823.527058917547;11835.230710003822;19220.615587688168;19425.514362140777;19464;19591.804081959282;19644.410667679993;7527.236381809095;7724.8455030900195;7780.8054798629355;7783.143854176036;7791.883121753178;956.8660387545749;1084.983725244122;1185.8458400408065;1202.8376169217045;1226.3132645718426;31931.52102718461;31988.520172197437;32499.51250731241;32862;33158;1077.1167642533205;1086.5979587552656;1186.288227063755;1188.5245901639414;1206.2943178240828;13980.300984950713;14343.85656143446;17070.658586828195;17081.658366832595;17434.302627894995;360419;365203;366143;366198.21116993844;367117;52799.73600131975;53030.73484632629;53212.46787532075;53259;53383.46616533863;1368.117564171104;1378.0973462382156;1396.8672976067257;1399.6920677450944;1399.7760358342616;29483;29892.645760928503;30142.0336364178;30305.848470757504;30459.2385190372;43678.56321436872;44124;44174;44229.33655995227;44260.77869610631;273106;285104;286629;287348;287824;29940.550891736206;30413.695863041085;30661.386772264876;30664.693353067076;30866.228344291572;35736.28527429385;36589;36699.63300366962;36788.264234715694;36958.445623315136;26557.468850622492;29924.25189370196;30952.84523577368;31044.689553105083;31340.52989205118;29016.854915725286;29888.55167172451;31223.687763122987;31303.373932520768;31449.21376965594;32179;32324.515132272565;32473.675263247063;38792.6120738789;40237.19525609413;28906.855465722536;29872.25319367033;30068.69931300659;30190.396192076474;30391.696083038885;24149.637755434032;25137.72658648071;25818.741812581633;25877.353066173495;26299.73700262973 01:40:56 INFO - PROCESS | 9137 | |2;jquery.html;344.27701826165054;345.925625990412;357.69595843532994;358.87439396211323;359.8398712572906;16034.43879464219;16670.499885003454;17045.403410880623;17199.65600687987;17229.483115506522;15906.284217210225;15934.681306373894;16396.09821459819;16565.171741412913;16620.418285360014;5296.576273898079;5313.149896016628;5447.6731396116165;5488.7530061147345;5510.862228444301;5431.158170483582;5467.535259502947;5468.343798744137;5472.945270547303;5476.397596264408;3927.273454410929;4071.2671719090554;5368.167933970221;5459.727013649322;5705.51503122233;5818.185454036438;5842.094475356326;5881.7353219105025;5882.999890018686;5903.085021821625;5126.5642420394315;5248.396434410015;5249.186376111708;5256.763445644917;5260.132078207092;15277.236138193157;16037.438689645807;18870.3395381161;19056.0471976402;19140.61718765631;2057.825084867788;2179.553191595735;2180.683800848884;2264.569731750962;2824.7740180785695;9096.317776166748;9269.165775080275;11169.944150279278;12349.69125771854;12765.851073403346;1845;1868.2246867550086;1872.288530358455;1872.6722823505831;1894.2612381171355;59097.70451147717;59462.10806837944;61351.386486135016;61456.385436145516;61706.69146654238;10101.545430455648;10106.090451859222;10144.391336519833;10144.847827282596;10185.185185185168;13252.27112508802;13294.534691285759;13311.334433278298;13319.06766526334;13325.800112998313;7443.665035073434;7465.776026719207;7468.887966680504;7511.549307041595;7531.548107113591;7155.248698886646;7161.606111663908;7163.1404231491515;7203.207647158808;7305.634718264172;4103.856365027269;4222.577742225752;4387.27609944362;4439.622632076245;4445.222086134913;1729.535412037841;1758.5691505581215;1813.6644720726708;1814.7187185986193;1819.3534850959902;788.8540619985206;956.4261443134064;1013.2906965124442;1025.779457416659;1046.6127532812757;16236.75644865328;16960.660786784196;17262.568435789206;17289.56776080583;17464.65070698579;841.5876220651836;1035.6168217759478;1039.9220058495491;1042.9530671119817;1074.9247552671238;9045.954770226106;9220.723378298662;9271;9318.161365477139;9411.482368469662;532543;541402;545011;559727;562523;67283.32716672869;73307;74213;74487.62756186184;76372.23627763762;1161.9535218591332;1170.1341007654444;1192.493190394079;1218.208164692939;1239.1573729863778;14838.703225935637;15092.320845561757;15157.543284417381;15700.363767009258;16082.67834643324;33829;33860.492092619126;33860.661393386734;34314.48528272128;34679.306413871076;48137.75931120322;48313.516864830905;48455.5154448451;49884.50115498944;50136;7556.962215188889;7682.539047657158;7697.576633285223;7775.961120194363;7776.533407995538;10068.496575171359;11667.708307292385;11866.288022718665;11881.168318217988;11919.642410727693;7313.451491138292;8861.291096712377;9754.268429867647;9830.918598954253;10472.476376181314;9756.756081098029;9917.950410247902;10075.34510256831;10397.272190946562;10593.682189534326;9771.75570610712;10505.31715438494;10591.788164236517;10728.678139655824;11117.999380055833;7444.367228785397;7497.325240728361;7536.924630753622;7581.166071731995;7670.27132422419;9919.752006199902;10371.27401081917;10634.52144653508;10645.840312395165;10849.077828384676 01:40:56 INFO - PROCESS | 9137 | |3;mootools.html;1348.3393137362696;1468.0971202710332;1494.805675262216;1668.9332426702933;1820.9271629134828;6711.8657626847435;7601.505902116365;7807.141214466418;7809.531428114303;7819.374450043997;7292.7447539336135;7395.297446742551;7413.110426748784;7417.5549467032015;7418.703251869919;2010.5878294949573;2292.4612716011725;2325.848819826706;2362.3149286706835;2364.9830572853666;2316.837821352506;2335.6262997920335;2338.672585837984;2339.87130707811;2343.320437073247;2270.0579259607243;2281.543691261746;2329.7204335479764;2332.0322066342446;2334.48641298914;2278.396225000376;2303.1593468384003;2309.099451214028;2349.3774149850306;2350.1421980976993;2267.603169445357;2277.943051423711;2285.0288627333316;2290.4617414907484;2293.5642227976796;7625.389968802482;7673.577953212571;7692.192319806451;7700.730474433424;7701.037370328709;4675.041616468649;4785.712857228577;4798.328234047236;4800.039992001579;4833.830815921461;3089.1968088297203;3135.545345924851;3190;3212.1969507623094;3309.4043072246986;963.7686955130788;970.0929630795229;997.9151772099381;1000.0799264676515;1016.6035246253966;10751.139908807276;10760.139188864872;10762.408067556282;10765.461726913545;10789.082927951134;4274.893127671833;4342.696011279243;4374.278244089754;4391.714538554984;4404.427424434803;9215.63137474507;9256.49089300095;9281.118293762216;9304.8604270936;9308.48803315824;4732.219183834629;4741.928871066937;4749.121412538622;4749.95250047502;4753.928691069636;4348.043430445297;4349.673774466928;4353.303471444554;4362.8909277267685;4388.758618275961;3292.2921571862166;3584.551931008624;3617.276544691072;3679.5032670589662;3687.483752274684;1168.8772678868766;1179.4633441783967;1180.651707746217;1192.6541303022027;1193.3913704010843;1331.6670832291927;1337.4449603414669;1346;1356.2743931996336;1372.61566761307;7283.126024876943;7346.669399877019;7552.962235188789;7575.090989081235;7575.469717119859;1028.388109075099;1045.9895401046044;1127.774445110981;1129.4804389980536;1156.3582211872492;5402.35171779389;5443.42844001382;5447.237386765777;5448.046591846411;5453.509184173444;8610.78473038179;8817.603207855662;9034.186923176945;9280.211182049467;9427;9168.862467063;9298.72103836886;9308.720738377859;9311.674091406769;9328.953355233316;7132.108486439195;7194.928050719531;7323.084614423197;7381.963090184515;7394.408447324201;7271.527350722186;7336.119665640157;7337.59643219628;7361.595112268662;7365.631718414165;8282.296004839656;8284.212999765012;8505.574721264036;8641.179087986631;8675.436096653697;8690.91309086901;8702.173293537104;8854.734357969272;8865.157810008039;8867.778305542413;6578.5395022347975;6742.8651426972165;6778.389944904982;6782.25395206517;6792.66036698173;6528.706208220547;7083.2208457068655;7329.413646908128;7338.082739657543;7356.154042285206;6905.413039891666;6928.203256625553;7005.124359455068;7064.964675176591;7124.251953544803;7022.824429389306;7049.154101507852;7062.081929349357;7072.186698529735;7130.42956563484;6828.419584335188;6880.793576192722;6885.311468853275;6895.5173137881875;6907.758228461979;6455.0962865199845;6482.740690372332;6491.610503369813;6502.252240992347;6523.64119973406;6411.455026322815;6423.550351475352;6451.000094985285;6464.806055818333;6469.223693156663 01:40:56 INFO - PROCESS | 9137 | |4;prototype.html;327.41066081054106;328.25158638304646;329.30845225027446;331.8606185402132;334.12625983054306;5736.1682556029455;5867.88510183065;5877.50041246494;5892;5921.348651648326;5691.08942569189;5778.0466223073145;5805.448482394177;5850.531957443405;5851.6196447231005;4543.0459603483305;4546.772661366935;4579.656525760564;4580;4582.473015603215;4413.536578659243;4461.553844615545;4497.505274419811;4526.434195725535;4572.382728331682;4486.214912390318;4487.147441986029;4494.550544945512;4511.639068874499;4511.842085527007;4502.279635258359;4522.412086428776;4526.909461810746;4528.50186479487;4539.568740969603;4001.519817621904;4006.8397264109694;4007.1384652299603;4011.438398624195;4011.8997025074314;5431.293931788842;5574.777008919638;5579.69311687861;5601.271834661508;5615.017371959891;5271.683698978073;5275.366955965271;5275.683458992473;5281.551068159172;5282.7622756976025;5919.674417907014;6223.284322302902;6223.937760622426;6224.9688751556405;6228.159198508189;4317.69776115672;4364.89087772805;4370.235208838472;4374.081442896995;4378.5183629800695;6345.302016778151;6449.709763060673;6455.7417703292285;6464.224293084813;6464.74141034358;4535.365048893158;4540.931886021713;4544.1593305237975;4548.4541854977615;4549.590536851633;4507.233770259064;4598.724076555417;4604.723716577016;4609.147307748078;4620;5234.502722241381;5244.842654720364;5245.737713114329;5247.790088396498;5252.553532949666;6200.255969283715;6224;6236.376362363818;6245.6252624842655;6248.718807653667;1600.4878438899673;1621.691878543073;1626.6746650669913;1627.2839950422012;1627.3978627907513;1099.8515200447998;1110.4336788237895;1111.5164903266943;1125.7129431994952;1139.5726602524053;5823.941760582425;5888.381719919433;5888.587798854039;5890.028145355968;5895.115732640053;6402;6407.487401007908;6409.647469389229;6410.711517981609;6450.645214513153;5884;5886.646801191942;5890.646561206341;5894;5896.115582662635;3382.5095361172494;3473.7568370213844;3480.63453337401;3482.89551313461;3483.407820670492;6722.428593569602;6727.798166055026;6733.057371967929;6736.562123462058;6738.427233685192;6529.412352888263;6537.509686773511;6538.084668146464;6582.736690532421;6636.834079147963;6541.247756508063;6685.264620891698;6699.129113215251;6700.329967003261;6718.395344418928;6178.876422471435;6313.40022697843;6419.775307864203;6424.775132870327;6435.06691529735;6302.842428939313;6339.619622822645;6348.587341822951;6376.139221205263;6398.616083035033;6642.568233064835;6643.335666433318;6647.734090636513;6650.933490665225;6770.32296770319;4232;4375.256206444976;4398.164348773723;4407.801648925742;4411.867643970686;6363.077353783768;6363.61818290904;6382.0745991831855;6390.657961828068;6401.807945761635;6217.378262173746;6227;6231.5637905348;6234.9688251558455;6238.220222472191;6109.877802444015;6188.659623720739;6204.565680402328;6210.223722034746;6211.534134939807;6134.969325153345;6143.139960405636;6143.293521244936;6145.4161854623735;6152.600080994721;6328.525360597881;6330.240371155491;6330.778422755181;6333.493320534439;6335.968320158369;6063.242094738158;6110.541709371903;6175.505959523138;6176.474999625082;6182.783602573888 01:40:56 INFO - PROCESS | 9137 | |5;yui.html;752.9021227240457;755.2409828122736;822.1449692319987;829.286813340527;832.7002279179499;13905.652358691024;14073.57779266621;14088.36602352894;14090.71818563628;14096.64758381041;13246.735065298688;13346.065775395702;13346.532871349506;13354.065215434899;13386.397612107454;672.6166085331363;674.3930462583689;801.6112185589984;819.4960099538771;838.0697425857294;829.1211316005024;833.6040380819123;835.6239692138531;836.3852568362249;836.5357226739158;691.498663468986;875.1554749666602;879.7009016934242;880.3573391424264;880.6697488441835;694.0976730250679;698.0611078099972;698.7659134190052;848.9066202717696;863.7624653220352;636.3413866647998;637.0380725105125;637.4422380417135;639.8880195965734;640.2061443809689;13518.932405338008;13564.186148831102;13612.319384030858;13621.795673064911;13627.386767595382;13186.736265274736;13614.251216183105;13615.863841361559;13654.522091726842;13708.725825483434;10671.573137074585;10903.672889813319;11075.335479871153;11235.21353505255;11275.267107637977;3619.239959608485;3677.3196958562485;3702.777833329982;3773.9622603773887;3782.924341513182;45768.54231457709;45923.311150332775;46014.309785353245;46019.30971035437;46069;10268;10454.738631534121;10680.252382333318;10738.194635402377;11150.442477876237;18910.149043293084;18974.525636859187;18996.145173467226;18999.525011874815;19035.333763318216;6956.686949087303;7387.224341444178;7688.846223075507;7712.267334603203;7905.723299684483;4436.977815110969;4440.267355886307;4440.7335559866515;4458.866234012985;4557.612602928722;3177.7457803375673;3186.4901615741833;3190.3619276144864;3195.6005499312587;3201.79188352761;586.8034208540101;586.9853253668607;590.1943846649293;594.8364199845078;613.4969325153421;616.2204810914197;620.3207487800851;635.1140159477503;649.938255865692;664.1930054983122;8779.078196789373;8839.248663863644;8907.73276801697;8926.955365223263;8941.552922353987;552.0754866590026;611.3916652930362;637.1271358239242;651.6090345792582;692.8337199072187;3883.3980732986433;3933.527976642764;4052.5744796796503;4094.2835003874798;4188.120494696148;51530.22704659433;52107.21839172416;52136;52231.73884130631;52326.47673523216;47728;48218.5178148221;48411.51588484141;49035.754821225666;49116.263256051185;41737.79131104325;42314;42522;44566;44820.55179448229;8158.592070396575;8489.74530764078;8612.698555550525;8747.518886461052;8761.824763504821;33895;34058;34460;35498.82250588731;35623.46564801478;40766.59233407628;42119.789401052796;44901.32648010217;44989;47653;10910.127189824954;10993.835092473459;11001;11459.083273337947;11676.124290678063;11451.427428628369;11791.469383877575;11853.34806585646;12002.21985570935;12082;10933.18001149933;11138.554457821596;11163.274387164809;11521.596744114251;11847.822282665595;10656.094231990368;11146.331220126818;11386.146039046938;11416.257943233662;11639.53441862316;11194.44027798623;11281.605143819927;11317.547298107984;11386.886131138583;11641.301521908712;9050.931319811938;9339.346245762732;9370.812583748151;9488.902665840049;9490.068707058088;8540.91459085426;8842.204201621886;8877.600507977286;9028.142326478974;9374.578143983674 01:40:56 INFO - PROCESS | 9137 | __end_tp_report 01:40:56 INFO - PROCESS | 9137 | __start_cc_report 01:40:56 INFO - PROCESS | 9137 | _x_x_mozilla_cycle_collect,912 01:40:56 INFO - PROCESS | 9137 | __end_cc_report 01:40:56 INFO - PROCESS | 9137 | __startTimestamp1455183656110__endTimestamp 01:40:56 INFO - PROCESS | 9137 | 01:40:56 INFO - PROCESS | 9137 | ------- Summary: start ------- 01:40:56 INFO - PROCESS | 9137 | Number of tests: 6 01:40:56 INFO - PROCESS | 9137 | 01:40:56 INFO - PROCESS | 9137 | [#0] dojo.html Cycles:165 Average:5165.55 Median:5379.57 stddev:548.60 (10.2%) stddev-sans-first:526.46 01:40:56 INFO - PROCESS | 9137 | Values: 3127.3 3189.1 3224.6 3226.1 3259.9 5063.0 5129.2 5178.3 5192.9 5211.0 5132.9 5179.9 5212.9 5221.7 5314.9 4727.6 4752.1 4765.3 4778.5 4924.3 4834.3 4834.8 4868.1 4889.6 4900.1 4670.5 4677.9 4752.4 4755.4 4760.1 4768.5 4770.6 4790.8 4818.1 4839.7 4721.2 4765.5 4771.7 4773.3 4819.8 5005.0 5079.7 5087.7 5087.7 5107.2 5554.4 5557.9 5558.7 5559.6 5574.4 5570.9 5577.4 5584.0 5587.5 5601.7 5062.2 5132.5 5231.8 5234.9 5314.9 5607.6 5614.9 5620.0 5642.4 5644.5 5406.8 5416.6 5418.2 5422.0 5430.5 5546.1 5591.5 5629.9 5634.4 5664.9 5550.8 5554.3 5562.2 5566.3 5572.3 5523.5 5553.1 5557.2 5557.5 5560.8 4209.4 4257.5 4296.0 4302.7 4304.8 3858.7 3870.3 3870.4 3907.1 3910.5 5068.3 5133.9 5144.0 5149.9 5187.7 5498.4 5510.9 5513.9 5544.1 5569.7 5099.1 5115.6 5117.5 5120.9 5162.8 4638.2 4679.4 4747.8 4750.0 4752.4 5729.7 5768.1 5784.1 5787.1 5843.4 5486.8 5522.3 5530.7 5531.1 5531.6 5589.8 5700.7 5712.6 5714.4 5736.3 5475.9 5476.0 5482.2 5487.1 5533.7 5543.7 5545.6 5546.6 5555.4 5605.2 5353.6 5379.6 5410.8 5440.8 5466.8 5461.2 5465.5 5468.0 5468.8 5481.2 5338.3 5379.6 5388.1 5388.3 5436.6 5334.4 5395.6 5492.1 5533.8 5540.0 5298.3 5298.9 5341.5 5346.2 5383.3 01:40:56 INFO - PROCESS | 9137 | 01:40:56 INFO - PROCESS | 9137 | [#1] ext.html Cycles:180 Average:45992.01 Median:19504.14 stddev:79918.68 (409.8%) stddev-sans-first:80069.99 01:40:56 INFO - PROCESS | 9137 | Values: 533.5 559.4 567.2 597.8 604.9 27984.2 35463.6 35841.5 35948.6 35965.1 39424.2 39582.4 39793.0 39881.4 39960.6 8465.8 8654.2 8674.8 8684.4 8684.6 8364.7 8495.4 8501.1 8509.7 8705.1 8691.8 8783.5 8792.6 8792.7 8796.3 8618.7 8670.9 8680.6 8682.3 8700.3 8681.1 8823.8 8825.2 8832.6 8839.6 39370.2 39726.4 39844.0 39894.0 39934.0 3502.0 3520.2 3544.6 3615.5 3661.9 25920.5 26397.7 26558.9 26560.9 26611.6 3714.7 3718.2 3730.4 3795.0 3853.3 253115.7 254010.0 254570.0 254795.0 255224.0 52514.0 53366.7 58348.7 60377.0 61067.1 52585.2 52754.5 52787.0 52933.7 52988.7 14498.5 14688.0 14689.3 14741.3 14748.2 10563.8 11677.1 11810.6 11823.5 11835.2 19220.6 19425.5 19464.0 19591.8 19644.4 7527.2 7724.8 7780.8 7783.1 7791.9 956.9 1085.0 1185.8 1202.8 1226.3 31931.5 31988.5 32499.5 32862.0 33158.0 1077.1 1086.6 1186.3 1188.5 1206.3 13980.3 14343.9 17070.7 17081.7 17434.3 360419.0 365203.0 366143.0 366198.2 367117.0 52799.7 53030.7 53212.5 53259.0 53383.5 1368.1 1378.1 1396.9 1399.7 1399.8 29483.0 29892.6 30142.0 30305.8 30459.2 43678.6 44124.0 44174.0 44229.3 44260.8 273106.0 285104.0 286629.0 287348.0 287824.0 29940.6 30413.7 30661.4 30664.7 30866.2 35736.3 36589.0 36699.6 36788.3 36958.4 26557.5 29924.3 30952.8 31044.7 31340.5 29016.9 29888.6 31223.7 31303.4 31449.2 32179.0 32324.5 32473.7 38792.6 40237.2 28906.9 29872.3 30068.7 30190.4 30391.7 24149.6 25137.7 25818.7 25877.4 26299.7 01:40:56 INFO - PROCESS | 9137 | 01:40:56 INFO - PROCESS | 9137 | [#2] jquery.html Cycles:180 Average:28178.41 Median:359.36 stddev:89619.67 (24938.9%) stddev-sans-first:89846.71 01:40:56 INFO - PROCESS | 9137 | Values: 344.3 345.9 357.7 358.9 359.8 16034.4 16670.5 17045.4 17199.7 17229.5 15906.3 15934.7 16396.1 16565.2 16620.4 5296.6 5313.1 5447.7 5488.8 5510.9 5431.2 5467.5 5468.3 5472.9 5476.4 3927.3 4071.3 5368.2 5459.7 5705.5 5818.2 5842.1 5881.7 5883.0 5903.1 5126.6 5248.4 5249.2 5256.8 5260.1 15277.2 16037.4 18870.3 19056.0 19140.6 2057.8 2179.6 2180.7 2264.6 2824.8 9096.3 9269.2 11169.9 12349.7 12765.9 1845.0 1868.2 1872.3 1872.7 1894.3 59097.7 59462.1 61351.4 61456.4 61706.7 10101.5 10106.1 10144.4 10144.8 10185.2 13252.3 13294.5 13311.3 13319.1 13325.8 7443.7 7465.8 7468.9 7511.5 7531.5 7155.2 7161.6 7163.1 7203.2 7305.6 4103.9 4222.6 4387.3 4439.6 4445.2 1729.5 1758.6 1813.7 1814.7 1819.4 788.9 956.4 1013.3 1025.8 1046.6 16236.8 16960.7 17262.6 17289.6 17464.7 841.6 1035.6 1039.9 1043.0 1074.9 9046.0 9220.7 9271.0 9318.2 9411.5 532543.0 541402.0 545011.0 559727.0 562523.0 67283.3 73307.0 74213.0 74487.6 76372.2 1162.0 1170.1 1192.5 1218.2 1239.2 14838.7 15092.3 15157.5 15700.4 16082.7 33829.0 33860.5 33860.7 34314.5 34679.3 48137.8 48313.5 48455.5 49884.5 50136.0 7557.0 7682.5 7697.6 7776.0 7776.5 10068.5 11667.7 11866.3 11881.2 11919.6 7313.5 8861.3 9754.3 9830.9 10472.5 9756.8 9918.0 10075.3 10397.3 10593.7 9771.8 10505.3 10591.8 10728.7 11118.0 7444.4 7497.3 7536.9 7581.2 7670.3 9919.8 10371.3 10634.5 10645.8 10849.1 01:40:56 INFO - PROCESS | 9137 | 01:40:56 INFO - PROCESS | 9137 | [#3] mootools.html Cycles:180 Average:5450.52 Median:6459.95 stddev:2794.29 (43.3%) stddev-sans-first:2785.11 01:40:56 INFO - PROCESS | 9137 | Values: 1348.3 1468.1 1494.8 1668.9 1820.9 6711.9 7601.5 7807.1 7809.5 7819.4 7292.7 7395.3 7413.1 7417.6 7418.7 2010.6 2292.5 2325.8 2362.3 2365.0 2316.8 2335.6 2338.7 2339.9 2343.3 2270.1 2281.5 2329.7 2332.0 2334.5 2278.4 2303.2 2309.1 2349.4 2350.1 2267.6 2277.9 2285.0 2290.5 2293.6 7625.4 7673.6 7692.2 7700.7 7701.0 4675.0 4785.7 4798.3 4800.0 4833.8 3089.2 3135.5 3190.0 3212.2 3309.4 963.8 970.1 997.9 1000.1 1016.6 10751.1 10760.1 10762.4 10765.5 10789.1 4274.9 4342.7 4374.3 4391.7 4404.4 9215.6 9256.5 9281.1 9304.9 9308.5 4732.2 4741.9 4749.1 4750.0 4753.9 4348.0 4349.7 4353.3 4362.9 4388.8 3292.3 3584.6 3617.3 3679.5 3687.5 1168.9 1179.5 1180.7 1192.7 1193.4 1331.7 1337.4 1346.0 1356.3 1372.6 7283.1 7346.7 7553.0 7575.1 7575.5 1028.4 1046.0 1127.8 1129.5 1156.4 5402.4 5443.4 5447.2 5448.0 5453.5 8610.8 8817.6 9034.2 9280.2 9427.0 9168.9 9298.7 9308.7 9311.7 9329.0 7132.1 7194.9 7323.1 7382.0 7394.4 7271.5 7336.1 7337.6 7361.6 7365.6 8282.3 8284.2 8505.6 8641.2 8675.4 8690.9 8702.2 8854.7 8865.2 8867.8 6578.5 6742.9 6778.4 6782.3 6792.7 6528.7 7083.2 7329.4 7338.1 7356.2 6905.4 6928.2 7005.1 7065.0 7124.3 7022.8 7049.2 7062.1 7072.2 7130.4 6828.4 6880.8 6885.3 6895.5 6907.8 6455.1 6482.7 6491.6 6502.3 6523.6 6411.5 6423.6 6451.0 6464.8 6469.2 01:40:56 INFO - PROCESS | 9137 | 01:40:56 INFO - PROCESS | 9137 | [#4] prototype.html Cycles:180 Average:5221.82 Median:5887.51 stddev:1552.43 (26.4%) stddev-sans-first:1512.70 01:40:56 INFO - PROCESS | 9137 | Values: 327.4 328.3 329.3 331.9 334.1 5736.2 5867.9 5877.5 5892.0 5921.3 5691.1 5778.0 5805.4 5850.5 5851.6 4543.0 4546.8 4579.7 4580.0 4582.5 4413.5 4461.6 4497.5 4526.4 4572.4 4486.2 4487.1 4494.6 4511.6 4511.8 4502.3 4522.4 4526.9 4528.5 4539.6 4001.5 4006.8 4007.1 4011.4 4011.9 5431.3 5574.8 5579.7 5601.3 5615.0 5271.7 5275.4 5275.7 5281.6 5282.8 5919.7 6223.3 6223.9 6225.0 6228.2 4317.7 4364.9 4370.2 4374.1 4378.5 6345.3 6449.7 6455.7 6464.2 6464.7 4535.4 4540.9 4544.2 4548.5 4549.6 4507.2 4598.7 4604.7 4609.1 4620.0 5234.5 5244.8 5245.7 5247.8 5252.6 6200.3 6224.0 6236.4 6245.6 6248.7 1600.5 1621.7 1626.7 1627.3 1627.4 1099.9 1110.4 1111.5 1125.7 1139.6 5823.9 5888.4 5888.6 5890.0 5895.1 6402.0 6407.5 6409.6 6410.7 6450.6 5884.0 5886.6 5890.6 5894.0 5896.1 3382.5 3473.8 3480.6 3482.9 3483.4 6722.4 6727.8 6733.1 6736.6 6738.4 6529.4 6537.5 6538.1 6582.7 6636.8 6541.2 6685.3 6699.1 6700.3 6718.4 6178.9 6313.4 6419.8 6424.8 6435.1 6302.8 6339.6 6348.6 6376.1 6398.6 6642.6 6643.3 6647.7 6650.9 6770.3 4232.0 4375.3 4398.2 4407.8 4411.9 6363.1 6363.6 6382.1 6390.7 6401.8 6217.4 6227.0 6231.6 6235.0 6238.2 6109.9 6188.7 6204.6 6210.2 6211.5 6135.0 6143.1 6143.3 6145.4 6152.6 6328.5 6330.2 6330.8 6333.5 6336.0 6063.2 6110.5 6175.5 6176.5 6182.8 01:40:56 INFO - PROCESS | 9137 | 01:40:56 INFO - PROCESS | 9137 | [#5] yui.html Cycles:180 Average:13495.38 Median:44860.94 stddev:15015.48 (33.5%) stddev-sans-first:15027.11 01:40:56 INFO - PROCESS | 9137 | Values: 752.9 755.2 822.1 829.3 832.7 13905.7 14073.6 14088.4 14090.7 14096.6 13246.7 13346.1 13346.5 13354.1 13386.4 672.6 674.4 801.6 819.5 838.1 829.1 833.6 835.6 836.4 836.5 691.5 875.2 879.7 880.4 880.7 694.1 698.1 698.8 848.9 863.8 636.3 637.0 637.4 639.9 640.2 13518.9 13564.2 13612.3 13621.8 13627.4 13186.7 13614.3 13615.9 13654.5 13708.7 10671.6 10903.7 11075.3 11235.2 11275.3 3619.2 3677.3 3702.8 3774.0 3782.9 45768.5 45923.3 46014.3 46019.3 46069.0 10268.0 10454.7 10680.3 10738.2 11150.4 18910.1 18974.5 18996.1 18999.5 19035.3 6956.7 7387.2 7688.8 7712.3 7905.7 4437.0 4440.3 4440.7 4458.9 4557.6 3177.7 3186.5 3190.4 3195.6 3201.8 586.8 587.0 590.2 594.8 613.5 616.2 620.3 635.1 649.9 664.2 8779.1 8839.2 8907.7 8927.0 8941.6 552.1 611.4 637.1 651.6 692.8 3883.4 3933.5 4052.6 4094.3 4188.1 51530.2 52107.2 52136.0 52231.7 52326.5 47728.0 48218.5 48411.5 49035.8 49116.3 41737.8 42314.0 42522.0 44566.0 44820.6 8158.6 8489.7 8612.7 8747.5 8761.8 33895.0 34058.0 34460.0 35498.8 35623.5 40766.6 42119.8 44901.3 44989.0 47653.0 10910.1 10993.8 11001.0 11459.1 11676.1 11451.4 11791.5 11853.3 12002.2 12082.0 10933.2 11138.6 11163.3 11521.6 11847.8 10656.1 11146.3 11386.1 11416.3 11639.5 11194.4 11281.6 11317.5 11386.9 11641.3 9050.9 9339.3 9370.8 9488.9 9490.1 8540.9 8842.2 8877.6 9028.1 9374.6 01:40:56 INFO - PROCESS | 9137 | -------- Summary: end -------- 01:40:56 INFO - PROCESS | 9137 | 01:40:56 INFO - TEST-INFO | 9137: exit 0 01:40:56 INFO - TEST-OK | dromaeo_css | took 1112816ms 01:40:56 INFO - TEST-START | kraken 01:40:56 INFO - operating with platform_type : linux_ 01:40:56 INFO - Initialising browser for kraken test... 01:40:56 INFO - TEST-INFO | started process 9316 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp6BbP9Q/profile http://localhost:44501/getInfo.html) 01:41:00 INFO - PROCESS | 9316 | __metrics Screen width/height:1600/1200 01:41:00 INFO - PROCESS | 9316 | colorDepth:24 01:41:00 INFO - PROCESS | 9316 | Browser inner width/height: 1024/697 01:41:00 INFO - PROCESS | 9316 | __metrics 01:41:00 INFO - PROCESS | 9316 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:41:02 INFO - TEST-INFO | 9316: exit 0 01:41:02 INFO - Browser initialized. 01:41:02 INFO - Running cycle 1/1 for kraken test... 01:41:02 INFO - TEST-INFO | started process 9396 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp6BbP9Q/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:41:13 INFO - PROCESS | 9396 | RSS: Main: 153915392 01:41:13 INFO - PROCESS | 9396 | 01:41:16 INFO - PROCESS | 9396 | Cycle 1(1): loaded http://localhost:44501/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44501/tests/kraken/driver.html?testName=audio-beat-detection) 01:41:16 INFO - PROCESS | 9396 | RSS: Main: 196132864 01:41:16 INFO - PROCESS | 9396 | 01:41:19 INFO - PROCESS | 9396 | Cycle 1(1): loaded http://localhost:44501/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44501/tests/kraken/driver.html?testName=audio-dft) 01:41:19 INFO - PROCESS | 9396 | RSS: Main: 187584512 01:41:19 INFO - PROCESS | 9396 | 01:41:22 INFO - PROCESS | 9396 | Cycle 1(1): loaded http://localhost:44501/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44501/tests/kraken/driver.html?testName=audio-fft) 01:41:23 INFO - PROCESS | 9396 | RSS: Main: 169349120 01:41:23 INFO - PROCESS | 9396 | 01:41:25 INFO - PROCESS | 9396 | Cycle 1(1): loaded http://localhost:44501/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44501/tests/kraken/driver.html?testName=audio-oscillator) 01:41:26 INFO - PROCESS | 9396 | RSS: Main: 170991616 01:41:26 INFO - PROCESS | 9396 | 01:41:28 INFO - PROCESS | 9396 | Cycle 1(1): loaded http://localhost:44501/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44501/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:41:28 INFO - PROCESS | 9396 | RSS: Main: 172843008 01:41:28 INFO - PROCESS | 9396 | 01:41:31 INFO - PROCESS | 9396 | Cycle 1(1): loaded http://localhost:44501/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44501/tests/kraken/driver.html?testName=imaging-darkroom) 01:41:32 INFO - PROCESS | 9396 | RSS: Main: 172593152 01:41:32 INFO - PROCESS | 9396 | 01:41:35 INFO - PROCESS | 9396 | Cycle 1(1): loaded http://localhost:44501/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44501/tests/kraken/driver.html?testName=imaging-desaturate) 01:41:36 INFO - PROCESS | 9396 | RSS: Main: 174604288 01:41:36 INFO - PROCESS | 9396 | 01:41:39 INFO - PROCESS | 9396 | Cycle 1(1): loaded http://localhost:44501/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44501/tests/kraken/driver.html?testName=json-parse-financial) 01:41:39 INFO - PROCESS | 9396 | RSS: Main: 173449216 01:41:39 INFO - PROCESS | 9396 | 01:41:41 INFO - PROCESS | 9396 | Cycle 1(1): loaded http://localhost:44501/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44501/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:41:41 INFO - PROCESS | 9396 | RSS: Main: 185135104 01:41:41 INFO - PROCESS | 9396 | 01:41:43 INFO - PROCESS | 9396 | Cycle 1(1): loaded http://localhost:44501/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44501/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:41:44 INFO - PROCESS | 9396 | RSS: Main: 183111680 01:41:44 INFO - PROCESS | 9396 | 01:41:46 INFO - PROCESS | 9396 | Cycle 1(1): loaded http://localhost:44501/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44501/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:41:46 INFO - PROCESS | 9396 | RSS: Main: 191201280 01:41:46 INFO - PROCESS | 9396 | 01:41:49 INFO - PROCESS | 9396 | Cycle 1(1): loaded http://localhost:44501/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44501/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:41:49 INFO - PROCESS | 9396 | RSS: Main: 196112384 01:41:49 INFO - PROCESS | 9396 | 01:41:52 INFO - PROCESS | 9396 | Cycle 1(1): loaded http://localhost:44501/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44501/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:41:53 INFO - PROCESS | 9396 | RSS: Main: 196489216 01:41:53 INFO - PROCESS | 9396 | 01:41:54 INFO - PROCESS | 9396 | Cycle 1(1): loaded http://localhost:44501/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44501/tests/kraken/driver.html?testName=ai-astar) 01:41:55 INFO - PROCESS | 9396 | RSS: Main: 257552384 01:41:55 INFO - PROCESS | 9396 | 01:41:55 INFO - PROCESS | 9396 | __start_tp_report 01:41:55 INFO - PROCESS | 9396 | _x_x_mozilla_page_load 01:41:55 INFO - PROCESS | 9396 | _x_x_mozilla_page_load_details 01:41:55 INFO - PROCESS | 9396 | |i|pagename|runs| 01:41:55 INFO - PROCESS | 9396 | |0;ai-astar;109;111;107;110;110;111;100;110;110;111 01:41:55 INFO - PROCESS | 9396 | |1;audio-beat-detection;150;127;149;157;129;144;150;128;175;125 01:41:55 INFO - PROCESS | 9396 | |2;audio-dft;164;161;163;161;161;162;160;163;160;161 01:41:55 INFO - PROCESS | 9396 | |3;audio-fft;76;74;101;96;73;76;73;119;108;73 01:41:55 INFO - PROCESS | 9396 | |4;audio-oscillator;95;96;137;95;96;96;139;97;96;147 01:41:55 INFO - PROCESS | 9396 | |5;imaging-gaussian-blur;119;115;115;114;115;115;115;115;114;115 01:41:55 INFO - PROCESS | 9396 | |6;imaging-darkroom;146;145;145;146;146;147;146;146;152;145 01:41:55 INFO - PROCESS | 9396 | |7;imaging-desaturate;95;96;96;96;97;96;96;96;96;97 01:41:55 INFO - PROCESS | 9396 | |8;json-parse-financial;57;59;56;55;55;56;59;66;54;54 01:41:55 INFO - PROCESS | 9396 | |9;json-stringify-tinderbox;67;67;78;69;68;68;67;68;67;67 01:41:55 INFO - PROCESS | 9396 | |10;stanford-crypto-aes;85;84;86;84;89;85;94;85;94;95 01:41:55 INFO - PROCESS | 9396 | |11;stanford-crypto-ccm;117;127;119;115;115;123;126;116;116;115 01:41:55 INFO - PROCESS | 9396 | |12;stanford-crypto-pbkdf2;156;143;153;141;151;141;156;157;159;150 01:41:55 INFO - PROCESS | 9396 | |13;stanford-crypto-sha256-iterative;71;70;73;68;69;70;71;69;69;67 01:41:55 INFO - PROCESS | 9396 | __end_tp_report 01:41:55 INFO - PROCESS | 9396 | __start_cc_report 01:41:55 INFO - PROCESS | 9396 | _x_x_mozilla_cycle_collect,986 01:41:55 INFO - PROCESS | 9396 | __end_cc_report 01:41:55 INFO - PROCESS | 9396 | __startTimestamp1455183715105__endTimestamp 01:41:55 INFO - PROCESS | 9396 | 01:41:55 INFO - PROCESS | 9396 | ------- Summary: start ------- 01:41:55 INFO - PROCESS | 9396 | Number of tests: 14 01:41:55 INFO - PROCESS | 9396 | 01:41:55 INFO - PROCESS | 9396 | [#0] ai-astar Cycles:10 Average:108.90 Median:110.00 stddev:3.35 (3.0%) stddev-sans-first:3.55 01:41:55 INFO - PROCESS | 9396 | Values: 109.0 111.0 107.0 110.0 110.0 111.0 100.0 110.0 110.0 111.0 01:41:55 INFO - PROCESS | 9396 | 01:41:55 INFO - PROCESS | 9396 | [#1] audio-beat-detection Cycles:10 Average:143.40 Median:149.50 stddev:16.17 (10.8%) stddev-sans-first:16.98 01:41:55 INFO - PROCESS | 9396 | Values: 150.0 127.0 149.0 157.0 129.0 144.0 150.0 128.0 175.0 125.0 01:41:55 INFO - PROCESS | 9396 | 01:41:55 INFO - PROCESS | 9396 | [#2] audio-dft Cycles:10 Average:161.60 Median:161.50 stddev:1.35 (0.8%) stddev-sans-first:1.12 01:41:55 INFO - PROCESS | 9396 | Values: 164.0 161.0 163.0 161.0 161.0 162.0 160.0 163.0 160.0 161.0 01:41:55 INFO - PROCESS | 9396 | 01:41:55 INFO - PROCESS | 9396 | [#3] audio-fft Cycles:10 Average:86.90 Median:73.50 stddev:17.45 (23.7%) stddev-sans-first:18.06 01:41:55 INFO - PROCESS | 9396 | Values: 76.0 74.0 101.0 96.0 73.0 76.0 73.0 119.0 108.0 73.0 01:41:55 INFO - PROCESS | 9396 | 01:41:55 INFO - PROCESS | 9396 | [#4] audio-oscillator Cycles:10 Average:109.40 Median:96.00 stddev:21.96 (22.9%) stddev-sans-first:22.66 01:41:55 INFO - PROCESS | 9396 | Values: 95.0 96.0 137.0 95.0 96.0 96.0 139.0 97.0 96.0 147.0 01:41:55 INFO - PROCESS | 9396 | 01:41:55 INFO - PROCESS | 9396 | [#5] imaging-gaussian-blur Cycles:10 Average:115.20 Median:115.00 stddev:1.40 (1.2%) stddev-sans-first:0.44 01:41:55 INFO - PROCESS | 9396 | Values: 119.0 115.0 115.0 114.0 115.0 115.0 115.0 115.0 114.0 115.0 01:41:55 INFO - PROCESS | 9396 | 01:41:55 INFO - PROCESS | 9396 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:2.07 (1.4%) stddev-sans-first:2.19 01:41:55 INFO - PROCESS | 9396 | Values: 146.0 145.0 145.0 146.0 146.0 147.0 146.0 146.0 152.0 145.0 01:41:55 INFO - PROCESS | 9396 | 01:41:55 INFO - PROCESS | 9396 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.44 01:41:55 INFO - PROCESS | 9396 | Values: 95.0 96.0 96.0 96.0 97.0 96.0 96.0 96.0 96.0 97.0 01:41:55 INFO - PROCESS | 9396 | 01:41:55 INFO - PROCESS | 9396 | [#8] json-parse-financial Cycles:10 Average:57.10 Median:56.50 stddev:3.60 (6.4%) stddev-sans-first:3.82 01:41:55 INFO - PROCESS | 9396 | Values: 57.0 59.0 56.0 55.0 55.0 56.0 59.0 66.0 54.0 54.0 01:41:55 INFO - PROCESS | 9396 | 01:41:55 INFO - PROCESS | 9396 | [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:68.00 stddev:3.37 (5.0%) stddev-sans-first:3.53 01:41:55 INFO - PROCESS | 9396 | Values: 67.0 67.0 78.0 69.0 68.0 68.0 67.0 68.0 67.0 67.0 01:41:55 INFO - PROCESS | 9396 | 01:41:55 INFO - PROCESS | 9396 | [#10] stanford-crypto-aes Cycles:10 Average:88.10 Median:87.50 stddev:4.53 (5.2%) stddev-sans-first:4.67 01:41:55 INFO - PROCESS | 9396 | Values: 85.0 84.0 86.0 84.0 89.0 85.0 94.0 85.0 94.0 95.0 01:41:55 INFO - PROCESS | 9396 | 01:41:55 INFO - PROCESS | 9396 | [#11] stanford-crypto-ccm Cycles:10 Average:118.90 Median:118.00 stddev:4.70 (4.0%) stddev-sans-first:4.94 01:41:55 INFO - PROCESS | 9396 | Values: 117.0 127.0 119.0 115.0 115.0 123.0 126.0 116.0 116.0 115.0 01:41:55 INFO - PROCESS | 9396 | 01:41:55 INFO - PROCESS | 9396 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.70 Median:154.50 stddev:6.82 (4.4%) stddev-sans-first:6.95 01:41:55 INFO - PROCESS | 9396 | Values: 156.0 143.0 153.0 141.0 151.0 141.0 156.0 157.0 159.0 150.0 01:41:55 INFO - PROCESS | 9396 | 01:41:55 INFO - PROCESS | 9396 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:70.00 stddev:1.70 (2.4%) stddev-sans-first:1.74 01:41:55 INFO - PROCESS | 9396 | Values: 71.0 70.0 73.0 68.0 69.0 70.0 71.0 69.0 69.0 67.0 01:41:55 INFO - PROCESS | 9396 | -------- Summary: end -------- 01:41:55 INFO - PROCESS | 9396 | 01:41:55 INFO - TEST-INFO | 9396: exit 0 01:41:56 INFO - TEST-OK | kraken | took 59180ms 01:41:56 INFO - SUITE-END | took 1171s 01:41:56 INFO - Completed test suite (00:19:32) 01:41:56 INFO - Working with test: dromaeo_css 01:41:56 INFO - Generating results file: dromaeo_css 01:41:56 INFO - Working with test: kraken 01:41:56 INFO - Generating results file: kraken 01:41:56 INFO - javascript benchmark 01:41:56 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:41:56 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,35]] 01:41:56 INFO - process_Request line: dromaeo_css 6859.09 graph.html#tests=[[72,63,35]] 01:41:56 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:41:56 INFO - process_Request line: kraken 1521.00 graph.html#tests=[[232,63,35]] 01:41:56 INFO - RETURN: dromaeo_css: 6859.09 01:41:56 INFO - RETURN: kraken: 1521.00 01:41:56 INFO - javascript benchmark 01:41:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3127.343257915838, 3189.075168201222, 3224.6130464344283, 3226.080567038393, 3259.902202933913, 5063.0380227756705, 5129.2306154076905, 5178.326817513718, 5192.92210616841, 5211.035958347704, 5132.871678208037, 5179.922301165486, 5212.8696782580455, 5221.71280579568, 5314.893702125955, 4727.55088266615, 4752.07334569759, 4765.3328534005095, 4778.450478195017, 4924.261360795874, 4834.3473631059705, 4834.830780922668, 4868.05073010763, 4889.559939605435, 4900.117978763821, 4670.532946705336, 4677.859664210079, 4752.382190315271, 4755.358026666408, 4760.071786001731, 4768.451628062782, 4770.642201834877, 4790.784414701312, 4818.084563932842, 4839.7338146401935, 4721.220998535237, 4765.451973023112, 4771.737554434505, 4773.3078703588135, 4819.783109760069, 5004.9749751251375, 5079.74601269935, 5087.694738315713, 5087.720175390352, 5107.233914912756, 5554.416786237427, 5557.916631250535, 5558.749856256438, 5559.58303127263, 5574.414686457904, 5570.888582228333, 5577.386487486373, 5584.0, 5587.469190426903, 5601.719914004283, 5062.2406639004075, 5132.461091585367, 5231.843044708627, 5234.869128271824, 5314.867128321823, 5607.579431542651, 5614.859628509238, 5619.971900140473, 5642.351129620064, 5644.520215781622, 5406.837794866082, 5416.647917885325, 5418.187271909166, 5422.024035673538, 5430.484104010113, 5546.084895992116, 5591.4688104629995, 5629.859253518613, 5634.4365563443325, 5664.915026274609, 5550.777968881281, 5554.2779438672715, 5562.165675148679, 5566.276384070126, 5572.3034620672415, 5523.502884740393, 5553.08374118266, 5557.249771280906, 5557.472040156179, 5560.777568897199, 4209.3896385024, 4257.531671516131, 4296.0, 4302.720323178984, 4304.763238021939, 3858.7105967052585, 3870.3420418528917, 3870.3613903705573, 3907.0623050467684, 3910.4916360872903, 5068.341115655015, 5133.922991155136, 5144.0, 5149.871253218699, 5187.688738675692, 5498.422665620133, 5510.897820435849, 5513.862153446196, 5544.0575102232715, 5569.66582005081, 5099.056674515226, 5115.590752739772, 5117.462666420047, 5120.948790512121, 5162.819301324435, 4638.234691275969, 4679.438467383936, 4747.762611869462, 4750.049990002013, 4752.405949256343, 5729.684867332254, 5768.105943578752, 5784.074548072373, 5787.102999035156, 5843.386444423274, 5486.807961721321, 5522.337319521683, 5530.695811730394, 5531.115021596525, 5531.612787104864, 5589.832305030855, 5700.657960522382, 5712.571557133148, 5714.3999880012, 5736.340320862987, 5475.917861232005, 5476.014317422742, 5482.150266708666, 5487.122060470306, 5533.6956467393065, 5543.695096769555, 5545.556355491632, 5546.639468434539, 5555.388907220284, 5605.1872478491205, 5353.598480113929, 5379.569634429315, 5410.75651595687, 5440.782368705366, 5466.753996070266, 5461.15352120422, 5465.480779325958, 5467.972660136674, 5468.8085916994305, 5481.205225242238, 5338.279332290091, 5379.623426360117, 5388.137897936312, 5388.2725832012175, 5436.565074793928, 5334.3865455473115, 5395.568354531707, 5492.148716948879, 5533.7786488541615, 5539.972300138474, 5298.337707786527, 5298.920516192337, 5341.4925582069645, 5346.198070289488, 5383.327084114486], "unit": "score", "name": "dojo.html", "value": 5131.787510341222}, {"lowerIsBetter": false, "replicates": [533.5224973648582, 559.42099926576, 567.163433934946, 597.7907732293696, 604.8729766748983, 27984.160475185752, 35463.645363546355, 35841.46237806435, 35948.64051359486, 35965.10087247817, 39424.21151576967, 39582.406263906065, 39793.00517487064, 39881.40177897334, 39960.60039399612, 8465.830683386313, 8654.177853103945, 8674.783130421727, 8684.435511691752, 8684.56577171142, 8364.749057528254, 8495.447795893248, 8501.06488286288, 8509.74470765878, 8705.129487051308, 8691.826163476726, 8783.516906570136, 8792.560371981408, 8792.69225577105, 8796.296296296314, 8618.741437756877, 8670.913290867074, 8680.56597170139, 8682.30541556674, 8700.34747393948, 8681.131886811332, 8823.823523529494, 8825.249853762438, 8832.646694132227, 8839.602217900145, 39370.21259574792, 39726.40410393846, 39844.0, 39894.0, 39934.0, 3501.9824900875587, 3520.1903562180587, 3544.627814079536, 3615.475756015363, 3661.8535258589623, 25920.534210434762, 26397.73602263972, 26558.867205664043, 26560.86719566409, 26611.600825987625, 3714.684251838597, 3718.244344610998, 3730.403135498307, 3794.9810250948567, 3853.3064048471265, 253115.73442132855, 254010.0, 254570.0, 254795.0, 255224.0, 52514.0, 53366.73316633392, 58348.70825645845, 60377.0, 61067.11463082943, 52585.211221831705, 52754.472455275725, 52787.0, 52933.7353313231, 52988.73505632447, 14498.492552760603, 14688.0, 14689.265536723122, 14741.336639851232, 14748.188849613374, 10563.841542376871, 11677.065834733201, 11810.586629467927, 11823.527058917547, 11835.230710003822, 19220.615587688168, 19425.514362140777, 19464.0, 19591.804081959282, 19644.410667679993, 7527.236381809095, 7724.8455030900195, 7780.8054798629355, 7783.143854176036, 7791.883121753178, 956.8660387545749, 1084.983725244122, 1185.8458400408065, 1202.8376169217045, 1226.3132645718426, 31931.52102718461, 31988.520172197437, 32499.51250731241, 32862.0, 33158.0, 1077.1167642533205, 1086.5979587552656, 1186.288227063755, 1188.5245901639414, 1206.2943178240828, 13980.300984950713, 14343.85656143446, 17070.658586828195, 17081.658366832595, 17434.302627894995, 360419.0, 365203.0, 366143.0, 366198.21116993844, 367117.0, 52799.73600131975, 53030.73484632629, 53212.46787532075, 53259.0, 53383.46616533863, 1368.117564171104, 1378.0973462382156, 1396.8672976067257, 1399.6920677450944, 1399.7760358342616, 29483.0, 29892.645760928503, 30142.0336364178, 30305.848470757504, 30459.2385190372, 43678.56321436872, 44124.0, 44174.0, 44229.33655995227, 44260.77869610631, 273106.0, 285104.0, 286629.0, 287348.0, 287824.0, 29940.550891736206, 30413.695863041085, 30661.386772264876, 30664.693353067076, 30866.228344291572, 35736.28527429385, 36589.0, 36699.63300366962, 36788.264234715694, 36958.445623315136, 26557.468850622492, 29924.25189370196, 30952.84523577368, 31044.689553105083, 31340.52989205118, 29016.854915725286, 29888.55167172451, 31223.687763122987, 31303.373932520768, 31449.21376965594, 32179.0, 32324.515132272565, 32473.675263247063, 38792.6120738789, 40237.19525609413, 28906.855465722536, 29872.25319367033, 30068.69931300659, 30190.396192076474, 30391.696083038885, 24149.637755434032, 25137.72658648071, 25818.741812581633, 25877.353066173495, 26299.73700262973], "unit": "score", "name": "ext.html", "value": 18124.569980049157}, {"lowerIsBetter": false, "replicates": [344.27701826165054, 345.925625990412, 357.69595843532994, 358.87439396211323, 359.8398712572906, 16034.43879464219, 16670.499885003454, 17045.403410880623, 17199.65600687987, 17229.483115506522, 15906.284217210225, 15934.681306373894, 16396.09821459819, 16565.171741412913, 16620.418285360014, 5296.576273898079, 5313.149896016628, 5447.6731396116165, 5488.7530061147345, 5510.862228444301, 5431.158170483582, 5467.535259502947, 5468.343798744137, 5472.945270547303, 5476.397596264408, 3927.273454410929, 4071.2671719090554, 5368.167933970221, 5459.727013649322, 5705.51503122233, 5818.185454036438, 5842.094475356326, 5881.7353219105025, 5882.999890018686, 5903.085021821625, 5126.5642420394315, 5248.396434410015, 5249.186376111708, 5256.763445644917, 5260.132078207092, 15277.236138193157, 16037.438689645807, 18870.3395381161, 19056.0471976402, 19140.61718765631, 2057.825084867788, 2179.553191595735, 2180.683800848884, 2264.569731750962, 2824.7740180785695, 9096.317776166748, 9269.165775080275, 11169.944150279278, 12349.69125771854, 12765.851073403346, 1845.0, 1868.2246867550086, 1872.288530358455, 1872.6722823505831, 1894.2612381171355, 59097.70451147717, 59462.10806837944, 61351.386486135016, 61456.385436145516, 61706.69146654238, 10101.545430455648, 10106.090451859222, 10144.391336519833, 10144.847827282596, 10185.185185185168, 13252.27112508802, 13294.534691285759, 13311.334433278298, 13319.06766526334, 13325.800112998313, 7443.665035073434, 7465.776026719207, 7468.887966680504, 7511.549307041595, 7531.548107113591, 7155.248698886646, 7161.606111663908, 7163.1404231491515, 7203.207647158808, 7305.634718264172, 4103.856365027269, 4222.577742225752, 4387.27609944362, 4439.622632076245, 4445.222086134913, 1729.535412037841, 1758.5691505581215, 1813.6644720726708, 1814.7187185986193, 1819.3534850959902, 788.8540619985206, 956.4261443134064, 1013.2906965124442, 1025.779457416659, 1046.6127532812757, 16236.75644865328, 16960.660786784196, 17262.568435789206, 17289.56776080583, 17464.65070698579, 841.5876220651836, 1035.6168217759478, 1039.9220058495491, 1042.9530671119817, 1074.9247552671238, 9045.954770226106, 9220.723378298662, 9271.0, 9318.161365477139, 9411.482368469662, 532543.0, 541402.0, 545011.0, 559727.0, 562523.0, 67283.32716672869, 73307.0, 74213.0, 74487.62756186184, 76372.23627763762, 1161.9535218591332, 1170.1341007654444, 1192.493190394079, 1218.208164692939, 1239.1573729863778, 14838.703225935637, 15092.320845561757, 15157.543284417381, 15700.363767009258, 16082.67834643324, 33829.0, 33860.492092619126, 33860.661393386734, 34314.48528272128, 34679.306413871076, 48137.75931120322, 48313.516864830905, 48455.5154448451, 49884.50115498944, 50136.0, 7556.962215188889, 7682.539047657158, 7697.576633285223, 7775.961120194363, 7776.533407995538, 10068.496575171359, 11667.708307292385, 11866.288022718665, 11881.168318217988, 11919.642410727693, 7313.451491138292, 8861.291096712377, 9754.268429867647, 9830.918598954253, 10472.476376181314, 9756.756081098029, 9917.950410247902, 10075.34510256831, 10397.272190946562, 10593.682189534326, 9771.75570610712, 10505.31715438494, 10591.788164236517, 10728.678139655824, 11117.999380055833, 7444.367228785397, 7497.325240728361, 7536.924630753622, 7581.166071731995, 7670.27132422419, 9919.752006199902, 10371.27401081917, 10634.52144653508, 10645.840312395165, 10849.077828384676], "unit": "score", "name": "jquery.html", "value": 8362.846972362746}, {"lowerIsBetter": false, "replicates": [1348.3393137362696, 1468.0971202710332, 1494.805675262216, 1668.9332426702933, 1820.9271629134828, 6711.8657626847435, 7601.505902116365, 7807.141214466418, 7809.531428114303, 7819.374450043997, 7292.7447539336135, 7395.297446742551, 7413.110426748784, 7417.5549467032015, 7418.703251869919, 2010.5878294949573, 2292.4612716011725, 2325.848819826706, 2362.3149286706835, 2364.9830572853666, 2316.837821352506, 2335.6262997920335, 2338.672585837984, 2339.87130707811, 2343.320437073247, 2270.0579259607243, 2281.543691261746, 2329.7204335479764, 2332.0322066342446, 2334.48641298914, 2278.396225000376, 2303.1593468384003, 2309.099451214028, 2349.3774149850306, 2350.1421980976993, 2267.603169445357, 2277.943051423711, 2285.0288627333316, 2290.4617414907484, 2293.5642227976796, 7625.389968802482, 7673.577953212571, 7692.192319806451, 7700.730474433424, 7701.037370328709, 4675.041616468649, 4785.712857228577, 4798.328234047236, 4800.039992001579, 4833.830815921461, 3089.1968088297203, 3135.545345924851, 3190.0, 3212.1969507623094, 3309.4043072246986, 963.7686955130788, 970.0929630795229, 997.9151772099381, 1000.0799264676515, 1016.6035246253966, 10751.139908807276, 10760.139188864872, 10762.408067556282, 10765.461726913545, 10789.082927951134, 4274.893127671833, 4342.696011279243, 4374.278244089754, 4391.714538554984, 4404.427424434803, 9215.63137474507, 9256.49089300095, 9281.118293762216, 9304.8604270936, 9308.48803315824, 4732.219183834629, 4741.928871066937, 4749.121412538622, 4749.95250047502, 4753.928691069636, 4348.043430445297, 4349.673774466928, 4353.303471444554, 4362.8909277267685, 4388.758618275961, 3292.2921571862166, 3584.551931008624, 3617.276544691072, 3679.5032670589662, 3687.483752274684, 1168.8772678868766, 1179.4633441783967, 1180.651707746217, 1192.6541303022027, 1193.3913704010843, 1331.6670832291927, 1337.4449603414669, 1346.0, 1356.2743931996336, 1372.61566761307, 7283.126024876943, 7346.669399877019, 7552.962235188789, 7575.090989081235, 7575.469717119859, 1028.388109075099, 1045.9895401046044, 1127.774445110981, 1129.4804389980536, 1156.3582211872492, 5402.35171779389, 5443.42844001382, 5447.237386765777, 5448.046591846411, 5453.509184173444, 8610.78473038179, 8817.603207855662, 9034.186923176945, 9280.211182049467, 9427.0, 9168.862467063, 9298.72103836886, 9308.720738377859, 9311.674091406769, 9328.953355233316, 7132.108486439195, 7194.928050719531, 7323.084614423197, 7381.963090184515, 7394.408447324201, 7271.527350722186, 7336.119665640157, 7337.59643219628, 7361.595112268662, 7365.631718414165, 8282.296004839656, 8284.212999765012, 8505.574721264036, 8641.179087986631, 8675.436096653697, 8690.91309086901, 8702.173293537104, 8854.734357969272, 8865.157810008039, 8867.778305542413, 6578.5395022347975, 6742.8651426972165, 6778.389944904982, 6782.25395206517, 6792.66036698173, 6528.706208220547, 7083.2208457068655, 7329.413646908128, 7338.082739657543, 7356.154042285206, 6905.413039891666, 6928.203256625553, 7005.124359455068, 7064.964675176591, 7124.251953544803, 7022.824429389306, 7049.154101507852, 7062.081929349357, 7072.186698529735, 7130.42956563484, 6828.419584335188, 6880.793576192722, 6885.311468853275, 6895.5173137881875, 6907.758228461979, 6455.0962865199845, 6482.740690372332, 6491.610503369813, 6502.252240992347, 6523.64119973406, 6411.455026322815, 6423.550351475352, 6451.000094985285, 6464.806055818333, 6469.223693156663], "unit": "score", "name": "mootools.html", "value": 4505.316297958956}, {"lowerIsBetter": false, "replicates": [327.41066081054106, 328.25158638304646, 329.30845225027446, 331.8606185402132, 334.12625983054306, 5736.1682556029455, 5867.88510183065, 5877.50041246494, 5892.0, 5921.348651648326, 5691.08942569189, 5778.0466223073145, 5805.448482394177, 5850.531957443405, 5851.6196447231005, 4543.0459603483305, 4546.772661366935, 4579.656525760564, 4580.0, 4582.473015603215, 4413.536578659243, 4461.553844615545, 4497.505274419811, 4526.434195725535, 4572.382728331682, 4486.214912390318, 4487.147441986029, 4494.550544945512, 4511.639068874499, 4511.842085527007, 4502.279635258359, 4522.412086428776, 4526.909461810746, 4528.50186479487, 4539.568740969603, 4001.519817621904, 4006.8397264109694, 4007.1384652299603, 4011.438398624195, 4011.8997025074314, 5431.293931788842, 5574.777008919638, 5579.69311687861, 5601.271834661508, 5615.017371959891, 5271.683698978073, 5275.366955965271, 5275.683458992473, 5281.551068159172, 5282.7622756976025, 5919.674417907014, 6223.284322302902, 6223.937760622426, 6224.9688751556405, 6228.159198508189, 4317.69776115672, 4364.89087772805, 4370.235208838472, 4374.081442896995, 4378.5183629800695, 6345.302016778151, 6449.709763060673, 6455.7417703292285, 6464.224293084813, 6464.74141034358, 4535.365048893158, 4540.931886021713, 4544.1593305237975, 4548.4541854977615, 4549.590536851633, 4507.233770259064, 4598.724076555417, 4604.723716577016, 4609.147307748078, 4620.0, 5234.502722241381, 5244.842654720364, 5245.737713114329, 5247.790088396498, 5252.553532949666, 6200.255969283715, 6224.0, 6236.376362363818, 6245.6252624842655, 6248.718807653667, 1600.4878438899673, 1621.691878543073, 1626.6746650669913, 1627.2839950422012, 1627.3978627907513, 1099.8515200447998, 1110.4336788237895, 1111.5164903266943, 1125.7129431994952, 1139.5726602524053, 5823.941760582425, 5888.381719919433, 5888.587798854039, 5890.028145355968, 5895.115732640053, 6402.0, 6407.487401007908, 6409.647469389229, 6410.711517981609, 6450.645214513153, 5884.0, 5886.646801191942, 5890.646561206341, 5894.0, 5896.115582662635, 3382.5095361172494, 3473.7568370213844, 3480.63453337401, 3482.89551313461, 3483.407820670492, 6722.428593569602, 6727.798166055026, 6733.057371967929, 6736.562123462058, 6738.427233685192, 6529.412352888263, 6537.509686773511, 6538.084668146464, 6582.736690532421, 6636.834079147963, 6541.247756508063, 6685.264620891698, 6699.129113215251, 6700.329967003261, 6718.395344418928, 6178.876422471435, 6313.40022697843, 6419.775307864203, 6424.775132870327, 6435.06691529735, 6302.842428939313, 6339.619622822645, 6348.587341822951, 6376.139221205263, 6398.616083035033, 6642.568233064835, 6643.335666433318, 6647.734090636513, 6650.933490665225, 6770.32296770319, 4232.0, 4375.256206444976, 4398.164348773723, 4407.801648925742, 4411.867643970686, 6363.077353783768, 6363.61818290904, 6382.0745991831855, 6390.657961828068, 6401.807945761635, 6217.378262173746, 6227.0, 6231.5637905348, 6234.9688251558455, 6238.220222472191, 6109.877802444015, 6188.659623720739, 6204.565680402328, 6210.223722034746, 6211.534134939807, 6134.969325153345, 6143.139960405636, 6143.293521244936, 6145.4161854623735, 6152.600080994721, 6328.525360597881, 6330.240371155491, 6330.778422755181, 6333.493320534439, 6335.968320158369, 6063.242094738158, 6110.541709371903, 6175.505959523138, 6176.474999625082, 6182.783602573888], "unit": "score", "name": "prototype.html", "value": 4721.1761095138245}, {"lowerIsBetter": false, "replicates": [752.9021227240457, 755.2409828122736, 822.1449692319987, 829.286813340527, 832.7002279179499, 13905.652358691024, 14073.57779266621, 14088.36602352894, 14090.71818563628, 14096.64758381041, 13246.735065298688, 13346.065775395702, 13346.532871349506, 13354.065215434899, 13386.397612107454, 672.6166085331363, 674.3930462583689, 801.6112185589984, 819.4960099538771, 838.0697425857294, 829.1211316005024, 833.6040380819123, 835.6239692138531, 836.3852568362249, 836.5357226739158, 691.498663468986, 875.1554749666602, 879.7009016934242, 880.3573391424264, 880.6697488441835, 694.0976730250679, 698.0611078099972, 698.7659134190052, 848.9066202717696, 863.7624653220352, 636.3413866647998, 637.0380725105125, 637.4422380417135, 639.8880195965734, 640.2061443809689, 13518.932405338008, 13564.186148831102, 13612.319384030858, 13621.795673064911, 13627.386767595382, 13186.736265274736, 13614.251216183105, 13615.863841361559, 13654.522091726842, 13708.725825483434, 10671.573137074585, 10903.672889813319, 11075.335479871153, 11235.21353505255, 11275.267107637977, 3619.239959608485, 3677.3196958562485, 3702.777833329982, 3773.9622603773887, 3782.924341513182, 45768.54231457709, 45923.311150332775, 46014.309785353245, 46019.30971035437, 46069.0, 10268.0, 10454.738631534121, 10680.252382333318, 10738.194635402377, 11150.442477876237, 18910.149043293084, 18974.525636859187, 18996.145173467226, 18999.525011874815, 19035.333763318216, 6956.686949087303, 7387.224341444178, 7688.846223075507, 7712.267334603203, 7905.723299684483, 4436.977815110969, 4440.267355886307, 4440.7335559866515, 4458.866234012985, 4557.612602928722, 3177.7457803375673, 3186.4901615741833, 3190.3619276144864, 3195.6005499312587, 3201.79188352761, 586.8034208540101, 586.9853253668607, 590.1943846649293, 594.8364199845078, 613.4969325153421, 616.2204810914197, 620.3207487800851, 635.1140159477503, 649.938255865692, 664.1930054983122, 8779.078196789373, 8839.248663863644, 8907.73276801697, 8926.955365223263, 8941.552922353987, 552.0754866590026, 611.3916652930362, 637.1271358239242, 651.6090345792582, 692.8337199072187, 3883.3980732986433, 3933.527976642764, 4052.5744796796503, 4094.2835003874798, 4188.120494696148, 51530.22704659433, 52107.21839172416, 52136.0, 52231.73884130631, 52326.47673523216, 47728.0, 48218.5178148221, 48411.51588484141, 49035.754821225666, 49116.263256051185, 41737.79131104325, 42314.0, 42522.0, 44566.0, 44820.55179448229, 8158.592070396575, 8489.74530764078, 8612.698555550525, 8747.518886461052, 8761.824763504821, 33895.0, 34058.0, 34460.0, 35498.82250588731, 35623.46564801478, 40766.59233407628, 42119.789401052796, 44901.32648010217, 44989.0, 47653.0, 10910.127189824954, 10993.835092473459, 11001.0, 11459.083273337947, 11676.124290678063, 11451.427428628369, 11791.469383877575, 11853.34806585646, 12002.21985570935, 12082.0, 10933.18001149933, 11138.554457821596, 11163.274387164809, 11521.596744114251, 11847.822282665595, 10656.094231990368, 11146.331220126818, 11386.146039046938, 11416.257943233662, 11639.53441862316, 11194.44027798623, 11281.605143819927, 11317.547298107984, 11386.886131138583, 11641.301521908712, 9050.931319811938, 9339.346245762732, 9370.812583748151, 9488.902665840049, 9490.068707058088, 8540.91459085426, 8842.204201621886, 8877.600507977286, 9028.142326478974, 9374.578143983674], "unit": "score", "name": "yui.html", "value": 6293.4989577831775}], "name": "dromaeo_css", "value": 6859.082557040623}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 111.0, 107.0, 110.0, 110.0, 111.0, 100.0, 110.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 108.9}, {"lowerIsBetter": true, "replicates": [150.0, 127.0, 149.0, 157.0, 129.0, 144.0, 150.0, 128.0, 175.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 143.4}, {"lowerIsBetter": true, "replicates": [164.0, 161.0, 163.0, 161.0, 161.0, 162.0, 160.0, 163.0, 160.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.6}, {"lowerIsBetter": true, "replicates": [76.0, 74.0, 101.0, 96.0, 73.0, 76.0, 73.0, 119.0, 108.0, 73.0], "unit": "score", "name": "audio-fft", "value": 86.9}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 137.0, 95.0, 96.0, 96.0, 139.0, 97.0, 96.0, 147.0], "unit": "score", "name": "audio-oscillator", "value": 109.4}, {"lowerIsBetter": true, "replicates": [119.0, 115.0, 115.0, 114.0, 115.0, 115.0, 115.0, 115.0, 114.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.2}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 146.0, 146.0, 147.0, 146.0, 146.0, 152.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [57.0, 59.0, 56.0, 55.0, 55.0, 56.0, 59.0, 66.0, 54.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 57.1}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 78.0, 69.0, 68.0, 68.0, 67.0, 68.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [85.0, 84.0, 86.0, 84.0, 89.0, 85.0, 94.0, 85.0, 94.0, 95.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.1}, {"lowerIsBetter": true, "replicates": [117.0, 127.0, 119.0, 115.0, 115.0, 123.0, 126.0, 116.0, 116.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.9}, {"lowerIsBetter": true, "replicates": [156.0, 143.0, 153.0, 141.0, 151.0, 141.0, 156.0, 157.0, 159.0, 150.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.7}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 73.0, 68.0, 69.0, 70.0, 71.0, 69.0, 69.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.7}], "name": "kraken", "value": 1521.0}]} 01:41:56 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,35]]", "result": "1521.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,35]]", "result": "6859.09"}}} 01:41:56 INFO - Return code: 0 01:41:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 01:41:56 INFO - # TBPL SUCCESS # 01:41:56 INFO - Running post-action listener: _resource_record_post_action 01:41:56 INFO - Running post-run listener: _resource_record_post_run 01:41:57 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 356352; Write bytes: 310759424; Read time: 104; Write time: 206612 01:41:57 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 15601664; Read time: 0; Write time: 6548 01:41:57 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 356352; Write bytes: 293572608; Read time: 104; Write time: 196204 01:41:57 INFO - Running post-run listener: _upload_blobber_files 01:41:57 INFO - Blob upload gear active. 01:41:57 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 01:41:57 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 01:41:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 01:41:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 01:41:58 INFO - (blobuploader) - INFO - Open directory for files ... 01:41:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 01:41:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:41:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:41:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:41:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:41:58 INFO - (blobuploader) - INFO - Done attempting. 01:41:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:41:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:41:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:41:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:41:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:41:59 INFO - (blobuploader) - INFO - Done attempting. 01:41:59 INFO - (blobuploader) - INFO - Iteration through files over. 01:41:59 INFO - Return code: 0 01:41:59 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 01:41:59 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 01:41:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e8c793189a0d2d0d8f0e50685694060c980dcce120c56735963fa3da17f71f01325fccf29d58f8800807989f46112ec76833a6b6e577bdb2ec4d2829892f323a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fcf3070727f1479c4db65a939e892e9a79fbfd08358fa665b5e1ee1d6dc52e981f545dfa36c8b794627f7b38b928f12b4ec6b03c64ecc1420efa5ea9f63cce59"} 01:41:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 01:41:59 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 01:41:59 INFO - Contents: 01:41:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e8c793189a0d2d0d8f0e50685694060c980dcce120c56735963fa3da17f71f01325fccf29d58f8800807989f46112ec76833a6b6e577bdb2ec4d2829892f323a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fcf3070727f1479c4db65a939e892e9a79fbfd08358fa665b5e1ee1d6dc52e981f545dfa36c8b794627f7b38b928f12b4ec6b03c64ecc1420efa5ea9f63cce59"} 01:41:59 INFO - Running post-run listener: copy_logs_to_upload_dir 01:41:59 INFO - Copying logs to upload dir... 01:41:59 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 01:41:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.047481 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-02-11 01:41:59.742290) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-11 01:41:59.750248) ========= 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=ed14279e38b05397cf4aa391000001a4-1455181951.930554-820759853 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e8c793189a0d2d0d8f0e50685694060c980dcce120c56735963fa3da17f71f01325fccf29d58f8800807989f46112ec76833a6b6e577bdb2ec4d2829892f323a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fcf3070727f1479c4db65a939e892e9a79fbfd08358fa665b5e1ee1d6dc52e981f545dfa36c8b794627f7b38b928f12b4ec6b03c64ecc1420efa5ea9f63cce59"} build_url:https://queue.taskcluster.net/v1/task/LvhqRS_gTwyvdV_RRmF29g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011317 build_url: 'https://queue.taskcluster.net/v1/task/LvhqRS_gTwyvdV_RRmF29g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e8c793189a0d2d0d8f0e50685694060c980dcce120c56735963fa3da17f71f01325fccf29d58f8800807989f46112ec76833a6b6e577bdb2ec4d2829892f323a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fcf3070727f1479c4db65a939e892e9a79fbfd08358fa665b5e1ee1d6dc52e981f545dfa36c8b794627f7b38b928f12b4ec6b03c64ecc1420efa5ea9f63cce59"}' ========= master_lag: 0.45 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-11 01:42:00.209676) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 01:42:00.213143) ========= 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=ed14279e38b05397cf4aa391000001a4-1455181951.930554-820759853 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004513 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 01:42:00.296915) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-11 01:42:00.297273) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-11 01:42:00.297596) ========= ========= Total master_lag: 1.13 =========