builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-049 starttime: 1458226810.13 results: success (0) buildid: 20160317053013 builduid: 7509b8c1e8104673b38dacf5027b8b0e revision: 21b7869572c92dab8d9fa07d333c43f2855a1b3b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-17 08:00:10.135143) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-17 08:00:10.135502) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-17 08:00:10.135805) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1458225981.900297-611633519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006365 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-17 08:00:10.158731) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-17 08:00:10.159014) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-17 08:00:10.171936) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 08:00:10.172211) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1458225981.900297-611633519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004598 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 08:00:10.221182) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-17 08:00:10.221468) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-17 08:00:10.221841) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 08:00:10.222356) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1458225981.900297-611633519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-17 08:00:10-- 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% 208M=0s 2016-03-17 08:00:10 (208 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.153908 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 08:00:10.388885) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 08:00:10.389229) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1458225981.900297-611633519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022694 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 08:00:10.438581) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 08:00:10.438921) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 21b7869572c92dab8d9fa07d333c43f2855a1b3b --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 21b7869572c92dab8d9fa07d333c43f2855a1b3b --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=8c719f637fb0c43bc4e5671e000001d0-1458225981.900297-611633519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-17 08:00:10,838 truncating revision to first 12 chars 2016-03-17 08:00:10,838 Setting DEBUG logging. 2016-03-17 08:00:10,838 attempt 1/10 2016-03-17 08:00:10,838 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/21b7869572c9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-17 08:00:11,087 unpacking tar archive at: fx-team-21b7869572c9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.514962 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 08:00:10.966597) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-17 08:00:10.966949) ========= echo 21b7869572c92dab8d9fa07d333c43f2855a1b3b in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'21b7869572c92dab8d9fa07d333c43f2855a1b3b'] 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=8c719f637fb0c43bc4e5671e000001d0-1458225981.900297-611633519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21b7869572c92dab8d9fa07d333c43f2855a1b3b program finished with exit code 0 elapsedTime=0.003417 script_repo_revision: '21b7869572c92dab8d9fa07d333c43f2855a1b3b' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-17 08:00:11.013985) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-17 08:00:11.014264) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-17 08:00:11.024259) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-03-17 08:00:11.024532) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c719f637fb0c43bc4e5671e000001d0-1458225981.900297-611633519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:00:11 INFO - MultiFileLogger online at 20160317 08:00:11 in /builds/slave/test-pgo 08:00:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:00:11 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 08:00:11 INFO - {'append_to_log': False, 08:00:11 INFO - 'base_work_dir': '/builds/slave/test-pgo', 08:00:11 INFO - 'blob_upload_branch': 'Fx-Team', 08:00:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 08:00:11 INFO - 'branch': 'Fx-Team', 08:00:11 INFO - 'buildbot_json_path': 'buildprops.json', 08:00:11 INFO - 'config_files': ('talos/linux_config.py',), 08:00:11 INFO - 'default_actions': ('clobber', 08:00:11 INFO - 'read-buildbot-config', 08:00:11 INFO - 'download-and-extract', 08:00:11 INFO - 'populate-webroot', 08:00:11 INFO - 'create-virtualenv', 08:00:11 INFO - 'install', 08:00:11 INFO - 'run-tests'), 08:00:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:00:11 INFO - 'download_minidump_stackwalk': True, 08:00:11 INFO - 'download_symbols': 'ondemand', 08:00:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:00:11 INFO - 'tooltool.py': '/tools/tooltool.py', 08:00:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:00:11 INFO - '/tools/misc-python/virtualenv.py')}, 08:00:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:00:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:00:11 INFO - 'installer_path': 'installer.exe', 08:00:11 INFO - 'log_level': 'info', 08:00:11 INFO - 'log_name': 'talos', 08:00:11 INFO - 'log_to_console': True, 08:00:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:00:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:00:11 INFO - 'opt_config_files': (), 08:00:11 INFO - 'pip_index': False, 08:00:11 INFO - 'sps_profile': False, 08:00:11 INFO - 'sps_profile_interval': 0, 08:00:11 INFO - 'suite': 'dromaeojs', 08:00:11 INFO - 'system_bits': '32', 08:00:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:00:11 INFO - 'title': 'talos-linux64-ix-049', 08:00:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:00:11 INFO - 'use_talos_json': True, 08:00:11 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 08:00:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:00:11 INFO - 'work_dir': 'build'} 08:00:11 INFO - ##### 08:00:11 INFO - ##### Running clobber step. 08:00:11 INFO - ##### 08:00:11 INFO - Running pre-action listener: _resource_record_pre_action 08:00:11 INFO - Running main action method: clobber 08:00:11 INFO - rmtree: /builds/slave/test-pgo/build 08:00:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 08:00:11 INFO - Running post-action listener: _resource_record_post_action 08:00:11 INFO - ##### 08:00:11 INFO - ##### Running read-buildbot-config step. 08:00:11 INFO - ##### 08:00:11 INFO - Running pre-action listener: _resource_record_pre_action 08:00:11 INFO - Running main action method: read_buildbot_config 08:00:11 INFO - Using buildbot properties: 08:00:11 INFO - { 08:00:11 INFO - "project": "", 08:00:11 INFO - "product": "firefox", 08:00:11 INFO - "script_repo_revision": "production", 08:00:11 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:00:11 INFO - "repository": "", 08:00:11 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:00:11 INFO - "buildid": "20160317053013", 08:00:11 INFO - "pgo_build": "True", 08:00:11 INFO - "basedir": "/builds/slave/test-pgo", 08:00:11 INFO - "buildnumber": 1006, 08:00:11 INFO - "slavename": "talos-linux64-ix-049", 08:00:11 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:00:11 INFO - "platform": "ubuntu64_hw", 08:00:11 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:00:11 INFO - "branch": "fx-team", 08:00:11 INFO - "repo_path": "integration/fx-team", 08:00:11 INFO - "revision": "21b7869572c92dab8d9fa07d333c43f2855a1b3b", 08:00:11 INFO - "stage_platform": "linux64-pgo", 08:00:11 INFO - "builduid": "7509b8c1e8104673b38dacf5027b8b0e", 08:00:11 INFO - "slavebuilddir": "test" 08:00:11 INFO - } 08:00:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/bughPZShQsyLYBaiDoWKqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 08:00:11 INFO - Running post-action listener: _resource_record_post_action 08:00:11 INFO - ##### 08:00:11 INFO - ##### Running download-and-extract step. 08:00:11 INFO - ##### 08:00:11 INFO - Running pre-action listener: _resource_record_pre_action 08:00:11 INFO - Running main action method: download_and_extract 08:00:11 INFO - mkdir: /builds/slave/test-pgo/build/tests 08:00:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:11 INFO - https://queue.taskcluster.net/v1/task/bughPZShQsyLYBaiDoWKqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:00:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bughPZShQsyLYBaiDoWKqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:00:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bughPZShQsyLYBaiDoWKqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:00:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bughPZShQsyLYBaiDoWKqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:00:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bughPZShQsyLYBaiDoWKqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:00:19 INFO - Downloaded 1361 bytes. 08:00:19 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:00:19 INFO - Using the following test package requirements: 08:00:19 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:00:19 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:00:19 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:00:19 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:19 INFO - u'jsshell-linux-x86_64.zip'], 08:00:19 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:00:19 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:00:19 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:00:19 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:00:19 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:00:19 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:00:19 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:00:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:19 INFO - https://queue.taskcluster.net/v1/task/bughPZShQsyLYBaiDoWKqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:00:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bughPZShQsyLYBaiDoWKqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:00:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bughPZShQsyLYBaiDoWKqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:00:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bughPZShQsyLYBaiDoWKqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:00:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bughPZShQsyLYBaiDoWKqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:00:21 INFO - Downloaded 23579218 bytes. 08:00:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 08:00:21 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 08:00:22 INFO - Return code: 0 08:00:22 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:00:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:22 INFO - https://queue.taskcluster.net/v1/task/bughPZShQsyLYBaiDoWKqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:00:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bughPZShQsyLYBaiDoWKqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:00:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bughPZShQsyLYBaiDoWKqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:00:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bughPZShQsyLYBaiDoWKqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:00:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bughPZShQsyLYBaiDoWKqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:00:27 INFO - Downloaded 23579218 bytes. 08:00:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 08:00:27 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 08:00:29 INFO - Return code: 0 08:00:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:29 INFO - https://queue.taskcluster.net/v1/task/bughPZShQsyLYBaiDoWKqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:00:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bughPZShQsyLYBaiDoWKqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:00:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bughPZShQsyLYBaiDoWKqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:00:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bughPZShQsyLYBaiDoWKqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:00:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bughPZShQsyLYBaiDoWKqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:00:30 INFO - Downloaded 10846565 bytes. 08:00:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 08:00:30 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 08:00:30 INFO - Return code: 0 08:00:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:30 INFO - https://queue.taskcluster.net/v1/task/bughPZShQsyLYBaiDoWKqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:00:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bughPZShQsyLYBaiDoWKqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:00:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bughPZShQsyLYBaiDoWKqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:00:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bughPZShQsyLYBaiDoWKqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:00:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bughPZShQsyLYBaiDoWKqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:00:32 INFO - Downloaded 57636531 bytes. 08:00:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bughPZShQsyLYBaiDoWKqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:00:32 INFO - mkdir: /builds/slave/test-pgo/properties 08:00:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 08:00:32 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 08:00:32 INFO - Contents: 08:00:32 INFO - build_url:https://queue.taskcluster.net/v1/task/bughPZShQsyLYBaiDoWKqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:00:33 INFO - Running post-action listener: _resource_record_post_action 08:00:33 INFO - Running post-action listener: set_extra_try_arguments 08:00:33 INFO - ##### 08:00:33 INFO - ##### Running populate-webroot step. 08:00:33 INFO - ##### 08:00:33 INFO - Running pre-action listener: _resource_record_pre_action 08:00:33 INFO - Running main action method: populate_webroot 08:00:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:00:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:00:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:00:33 INFO - '--tppagecycles', 08:00:33 INFO - '7'], 08:00:33 INFO - 'tests': ['tsvgm']}}, 08:00:33 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:00:33 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:00:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:00:33 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 08:00:33 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:00:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:00:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:00:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:33 INFO - 'talos_options': ['--e10s'], 08:00:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:00:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:33 INFO - 'tests': ['damp', 'tps']}, 08:00:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:33 INFO - 'talos_options': ['--e10s'], 08:00:33 INFO - 'tests': ['damp', 'tps']}, 08:00:33 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:00:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:00:33 INFO - 'other': {'tests': ['a11yr', 08:00:33 INFO - 'ts_paint', 08:00:33 INFO - 'tpaint', 08:00:33 INFO - 'sessionrestore', 08:00:33 INFO - 'sessionrestore_no_auto_restore', 08:00:33 INFO - 'tabpaint']}, 08:00:33 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:00:33 INFO - 'tests': ['a11yr', 08:00:33 INFO - 'ts_paint', 08:00:33 INFO - 'tpaint', 08:00:33 INFO - 'sessionrestore', 08:00:33 INFO - 'sessionrestore_no_auto_restore', 08:00:33 INFO - 'tabpaint']}, 08:00:33 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:00:33 INFO - 'tests': ['a11yr', 08:00:33 INFO - 'ts_paint', 08:00:33 INFO - 'tpaint', 08:00:33 INFO - 'sessionrestore', 08:00:33 INFO - 'sessionrestore_no_auto_restore', 08:00:33 INFO - 'tabpaint']}, 08:00:33 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:00:33 INFO - 'tests': ['a11yr', 08:00:33 INFO - 'ts_paint', 08:00:33 INFO - 'tpaint', 08:00:33 INFO - 'sessionrestore', 08:00:33 INFO - 'sessionrestore_no_auto_restore', 08:00:33 INFO - 'tabpaint']}, 08:00:33 INFO - 'other_l64': {'tests': ['a11yr', 08:00:33 INFO - 'ts_paint', 08:00:33 INFO - 'tpaint', 08:00:33 INFO - 'sessionrestore', 08:00:33 INFO - 'sessionrestore_no_auto_restore', 08:00:33 INFO - 'tabpaint']}, 08:00:33 INFO - 'other_nol64': {'tests': ['a11yr', 08:00:33 INFO - 'ts_paint', 08:00:33 INFO - 'tpaint', 08:00:33 INFO - 'sessionrestore', 08:00:33 INFO - 'sessionrestore_no_auto_restore', 08:00:33 INFO - 'tabpaint']}, 08:00:33 INFO - 'svgr': {'tests': ['tsvgx', 08:00:33 INFO - 'tsvgr_opacity', 08:00:33 INFO - 'tart', 08:00:33 INFO - 'tscrollx', 08:00:33 INFO - 'cart']}, 08:00:33 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:00:33 INFO - 'tests': ['tsvgx', 08:00:33 INFO - 'tsvgr_opacity', 08:00:33 INFO - 'tart', 08:00:33 INFO - 'tscrollx', 08:00:33 INFO - 'cart']}, 08:00:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:33 INFO - 'tests': ['tp5o']}, 08:00:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:33 INFO - 'talos_options': ['--e10s'], 08:00:33 INFO - 'tests': ['tp5o']}, 08:00:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:33 INFO - 'talos_options': ['--xperf_path', 08:00:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:00:33 INFO - 'tests': ['tp5n']}, 08:00:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:33 INFO - 'talos_options': ['--e10s', 08:00:33 INFO - '--xperf_path', 08:00:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:00:33 INFO - 'tests': ['tp5n']}}, 08:00:33 INFO - 'talos.zip': {'path': '', 08:00:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:00:33 INFO - Running post-action listener: _resource_record_post_action 08:00:33 INFO - ##### 08:00:33 INFO - ##### Running create-virtualenv step. 08:00:33 INFO - ##### 08:00:33 INFO - Running pre-action listener: _resource_record_pre_action 08:00:33 INFO - Running main action method: create_virtualenv 08:00:33 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 08:00:33 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 08:00:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 08:00:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:00:33 INFO - Using real prefix '/usr' 08:00:33 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 08:00:33 INFO - Installing distribute.............................................................................................................................................................................................done. 08:00:35 INFO - Installing pip.................done. 08:00:35 INFO - Return code: 0 08:00:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 08:00: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')]} 08:00:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00: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')]} 08:00:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:35 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f72eabedf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b5b6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b561d0>, '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 0x1b59750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b59be0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1458225981.900297-611633519', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:00:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 08:00:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:00:35 INFO - Using env: {'DISPLAY': ':0', 08:00:35 INFO - 'HOME': '/home/cltbld', 08:00:35 INFO - 'LANG': 'en_US.UTF-8', 08:00:35 INFO - 'LANGUAGE': 'en_US:en', 08:00:35 INFO - 'LOGNAME': 'cltbld', 08:00:35 INFO - 'MAIL': '/var/mail/cltbld', 08:00:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:35 INFO - 'MOZ_NO_REMOTE': '1', 08:00:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:35 INFO - 'NO_EM_RESTART': '1', 08:00:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:00:35 INFO - 'PWD': '/builds/slave/test-pgo', 08:00:35 INFO - 'SHELL': '/bin/bash', 08:00:35 INFO - 'SHLVL': '1', 08:00:35 INFO - 'TERM': 'linux', 08:00:35 INFO - 'TMOUT': '86400', 08:00:35 INFO - 'USER': 'cltbld', 08:00:35 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1458225981.900297-611633519', 08:00:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:35 INFO - '_': '/tools/buildbot/bin/python'} 08:00:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:36 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:00:36 INFO - Cleaning up... 08:00:36 INFO - Return code: 0 08:00:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 08:00:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:36 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f72eabedf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b5b6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b561d0>, '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 0x1b59750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b59be0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1458225981.900297-611633519', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:00:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 08:00:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:00:36 INFO - Using env: {'DISPLAY': ':0', 08:00:36 INFO - 'HOME': '/home/cltbld', 08:00:36 INFO - 'LANG': 'en_US.UTF-8', 08:00:36 INFO - 'LANGUAGE': 'en_US:en', 08:00:36 INFO - 'LOGNAME': 'cltbld', 08:00:36 INFO - 'MAIL': '/var/mail/cltbld', 08:00:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:36 INFO - 'MOZ_NO_REMOTE': '1', 08:00:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:36 INFO - 'NO_EM_RESTART': '1', 08:00:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:00:36 INFO - 'PWD': '/builds/slave/test-pgo', 08:00:36 INFO - 'SHELL': '/bin/bash', 08:00:36 INFO - 'SHLVL': '1', 08:00:36 INFO - 'TERM': 'linux', 08:00:36 INFO - 'TMOUT': '86400', 08:00:36 INFO - 'USER': 'cltbld', 08:00:36 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1458225981.900297-611633519', 08:00:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:36 INFO - '_': '/tools/buildbot/bin/python'} 08:00:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:36 INFO - Downloading/unpacking psutil>=0.7.1 08:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 08:00:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:00:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:00:38 INFO - Installing collected packages: psutil 08:00:38 INFO - Running setup.py install for psutil 08:00:38 INFO - building 'psutil._psutil_linux' extension 08:00:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:00:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:00:38 INFO - building 'psutil._psutil_posix' extension 08:00:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:00:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:00:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:00:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:00:38 INFO - Successfully installed psutil 08:00:38 INFO - Cleaning up... 08:00:38 INFO - Return code: 0 08:00:38 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 08:00:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:38 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 0x7f72eabedf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b5b6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b561d0>, '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 0x1b59750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b59be0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1458225981.900297-611633519', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:00:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 08:00:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:00:38 INFO - Using env: {'DISPLAY': ':0', 08:00:38 INFO - 'HOME': '/home/cltbld', 08:00:38 INFO - 'LANG': 'en_US.UTF-8', 08:00:38 INFO - 'LANGUAGE': 'en_US:en', 08:00:38 INFO - 'LOGNAME': 'cltbld', 08:00:38 INFO - 'MAIL': '/var/mail/cltbld', 08:00:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:38 INFO - 'MOZ_NO_REMOTE': '1', 08:00:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:38 INFO - 'NO_EM_RESTART': '1', 08:00:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:00:38 INFO - 'PWD': '/builds/slave/test-pgo', 08:00:38 INFO - 'SHELL': '/bin/bash', 08:00:38 INFO - 'SHLVL': '1', 08:00:38 INFO - 'TERM': 'linux', 08:00:38 INFO - 'TMOUT': '86400', 08:00:38 INFO - 'USER': 'cltbld', 08:00:38 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1458225981.900297-611633519', 08:00:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:38 INFO - '_': '/tools/buildbot/bin/python'} 08:00:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:38 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:40 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:00:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:00:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:00:40 INFO - Installing collected packages: mozsystemmonitor 08:00:40 INFO - Running setup.py install for mozsystemmonitor 08:00:40 INFO - Successfully installed mozsystemmonitor 08:00:40 INFO - Cleaning up... 08:00:41 INFO - Return code: 0 08:00:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 08:00:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:41 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 0x7f72eabedf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b5b6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b561d0>, '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 0x1b59750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b59be0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1458225981.900297-611633519', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:00:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 08:00:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:00:41 INFO - Using env: {'DISPLAY': ':0', 08:00:41 INFO - 'HOME': '/home/cltbld', 08:00:41 INFO - 'LANG': 'en_US.UTF-8', 08:00:41 INFO - 'LANGUAGE': 'en_US:en', 08:00:41 INFO - 'LOGNAME': 'cltbld', 08:00:41 INFO - 'MAIL': '/var/mail/cltbld', 08:00:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:41 INFO - 'MOZ_NO_REMOTE': '1', 08:00:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:41 INFO - 'NO_EM_RESTART': '1', 08:00:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:00:41 INFO - 'PWD': '/builds/slave/test-pgo', 08:00:41 INFO - 'SHELL': '/bin/bash', 08:00:41 INFO - 'SHLVL': '1', 08:00:41 INFO - 'TERM': 'linux', 08:00:41 INFO - 'TMOUT': '86400', 08:00:41 INFO - 'USER': 'cltbld', 08:00:41 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1458225981.900297-611633519', 08:00:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:41 INFO - '_': '/tools/buildbot/bin/python'} 08:00:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:41 INFO - Downloading/unpacking blobuploader==1.2.4 08:00:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:43 INFO - Downloading blobuploader-1.2.4.tar.gz 08:00:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:00:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:00:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 08:00:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:00:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:43 INFO - Downloading docopt-0.6.1.tar.gz 08:00:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 08:00:43 INFO - Installing collected packages: blobuploader, requests, docopt 08:00:43 INFO - Running setup.py install for blobuploader 08:00:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:00:43 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 08:00:43 INFO - Running setup.py install for requests 08:00:44 INFO - Running setup.py install for docopt 08:00:44 INFO - Successfully installed blobuploader requests docopt 08:00:44 INFO - Cleaning up... 08:00:44 INFO - Return code: 0 08:00:44 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:00:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:44 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 0x7f72eabedf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b5b6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b561d0>, '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 0x1b59750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b59be0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1458225981.900297-611633519', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:00:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 08:00:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:00:44 INFO - Using env: {'DISPLAY': ':0', 08:00:44 INFO - 'HOME': '/home/cltbld', 08:00:44 INFO - 'LANG': 'en_US.UTF-8', 08:00:44 INFO - 'LANGUAGE': 'en_US:en', 08:00:44 INFO - 'LOGNAME': 'cltbld', 08:00:44 INFO - 'MAIL': '/var/mail/cltbld', 08:00:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:44 INFO - 'MOZ_NO_REMOTE': '1', 08:00:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:44 INFO - 'NO_EM_RESTART': '1', 08:00:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:00:44 INFO - 'PWD': '/builds/slave/test-pgo', 08:00:44 INFO - 'SHELL': '/bin/bash', 08:00:44 INFO - 'SHLVL': '1', 08:00:44 INFO - 'TERM': 'linux', 08:00:44 INFO - 'TMOUT': '86400', 08:00:44 INFO - 'USER': 'cltbld', 08:00:44 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1458225981.900297-611633519', 08:00:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:44 INFO - '_': '/tools/buildbot/bin/python'} 08:00:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:00:44 INFO - Running setup.py (path:/tmp/pip-FBFCYK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:00:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:00:44 INFO - Running setup.py (path:/tmp/pip-sXWE_X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:00:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:00:44 INFO - Running setup.py (path:/tmp/pip-dtObVB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:00:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:00:44 INFO - Running setup.py (path:/tmp/pip-qK7eSx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:00:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:00:44 INFO - Running setup.py (path:/tmp/pip-oQs8No-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:00:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:00:44 INFO - Running setup.py (path:/tmp/pip-qSUCnM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:00:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:00:45 INFO - Running setup.py (path:/tmp/pip-27bJng-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:00:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:00:45 INFO - Running setup.py (path:/tmp/pip-pEPXuN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:00:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:00:45 INFO - Running setup.py (path:/tmp/pip-2AwJJm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:00:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:00:45 INFO - Running setup.py (path:/tmp/pip-_GJ2ug-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:00:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:00:45 INFO - Running setup.py (path:/tmp/pip-RG4FO3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:00:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:00:45 INFO - Running setup.py (path:/tmp/pip-Fr9h7D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:00:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:00:45 INFO - Running setup.py (path:/tmp/pip-b5998t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:00:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:00:45 INFO - Running setup.py (path:/tmp/pip-VozCrJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:00:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:00:45 INFO - Running setup.py (path:/tmp/pip-l5luJT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:00:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:00:45 INFO - Running setup.py (path:/tmp/pip-XpwXYl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:00:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:00:45 INFO - Running setup.py (path:/tmp/pip-HAFV3V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:00:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:00:45 INFO - Running setup.py install for manifestparser 08:00:45 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 08:00:45 INFO - Running setup.py install for mozcrash 08:00:46 INFO - Running setup.py install for mozdebug 08:00:46 INFO - Running setup.py install for mozdevice 08:00:46 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 08:00:46 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 08:00:46 INFO - Running setup.py install for mozfile 08:00:46 INFO - Running setup.py install for mozhttpd 08:00:46 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 08:00:46 INFO - Running setup.py install for mozinfo 08:00:46 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 08:00:46 INFO - Running setup.py install for mozInstall 08:00:46 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 08:00:46 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 08:00:46 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 08:00:46 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 08:00:46 INFO - Running setup.py install for mozleak 08:00:46 INFO - Running setup.py install for mozlog 08:00:46 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 08:00:46 INFO - Running setup.py install for moznetwork 08:00:46 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 08:00:46 INFO - Running setup.py install for mozprocess 08:00:47 INFO - Running setup.py install for mozprofile 08:00:47 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 08:00:47 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 08:00:47 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 08:00:47 INFO - Running setup.py install for mozrunner 08:00:47 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 08:00:47 INFO - Running setup.py install for mozscreenshot 08:00:47 INFO - Running setup.py install for moztest 08:00:47 INFO - Running setup.py install for mozversion 08:00:47 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 08:00:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:00:47 INFO - Cleaning up... 08:00:47 INFO - Return code: 0 08:00:47 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:00:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:47 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 0x7f72eabedf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b5b6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b561d0>, '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 0x1b59750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b59be0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1458225981.900297-611633519', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:00:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 08:00:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:00:47 INFO - Using env: {'DISPLAY': ':0', 08:00:47 INFO - 'HOME': '/home/cltbld', 08:00:47 INFO - 'LANG': 'en_US.UTF-8', 08:00:47 INFO - 'LANGUAGE': 'en_US:en', 08:00:47 INFO - 'LOGNAME': 'cltbld', 08:00:47 INFO - 'MAIL': '/var/mail/cltbld', 08:00:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:47 INFO - 'MOZ_NO_REMOTE': '1', 08:00:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:47 INFO - 'NO_EM_RESTART': '1', 08:00:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:00:47 INFO - 'PWD': '/builds/slave/test-pgo', 08:00:47 INFO - 'SHELL': '/bin/bash', 08:00:47 INFO - 'SHLVL': '1', 08:00:47 INFO - 'TERM': 'linux', 08:00:47 INFO - 'TMOUT': '86400', 08:00:47 INFO - 'USER': 'cltbld', 08:00:47 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1458225981.900297-611633519', 08:00:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:47 INFO - '_': '/tools/buildbot/bin/python'} 08:00:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:00:47 INFO - Running setup.py (path:/tmp/pip-KVkm3S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:00:47 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 08:00:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:00:47 INFO - Running setup.py (path:/tmp/pip-za_G79-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:00:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 08:00:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:00:47 INFO - Running setup.py (path:/tmp/pip-VEdmXh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:00:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 08:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:00:48 INFO - Running setup.py (path:/tmp/pip-z5N6jl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:00:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 08:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:00:48 INFO - Running setup.py (path:/tmp/pip-h85fdJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:00:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 08:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:00:48 INFO - Running setup.py (path:/tmp/pip-94AEgV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:00:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 08:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:00:48 INFO - Running setup.py (path:/tmp/pip-D16lO5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:00:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 08:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:00:48 INFO - Running setup.py (path:/tmp/pip-H3Y5HA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:00:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 08:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:00:48 INFO - Running setup.py (path:/tmp/pip-hTilg_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:00:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 08:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:00:48 INFO - Running setup.py (path:/tmp/pip-SD0IV5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:00:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 08:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:00:48 INFO - Running setup.py (path:/tmp/pip-kQznHw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:00:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 08:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:00:48 INFO - Running setup.py (path:/tmp/pip-p8XEWK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:00:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 08:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:00:48 INFO - Running setup.py (path:/tmp/pip-i66_s3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:00:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 08:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:00:48 INFO - Running setup.py (path:/tmp/pip-lWgIz_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:00:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 08:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:00:48 INFO - Running setup.py (path:/tmp/pip-tNa5Sn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:00:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 08:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:00:48 INFO - Running setup.py (path:/tmp/pip-v23iGQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:00:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 08:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:00:48 INFO - Running setup.py (path:/tmp/pip-FWVyc3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:00:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 08:00:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 08:00:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 08:00:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 08:00:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 08:00:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 08:00:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 08:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:50 INFO - Downloading blessings-1.6.tar.gz 08:00:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 08:00:50 INFO - Installing collected packages: blessings 08:00:50 INFO - Running setup.py install for blessings 08:00:51 INFO - Successfully installed blessings 08:00:51 INFO - Cleaning up... 08:00:51 INFO - Return code: 0 08:00:51 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 08:00:51 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:00:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:00:51 INFO - Reading from file tmpfile_stdout 08:00:51 INFO - Current package versions: 08:00:51 INFO - argparse == 1.2.1 08:00:51 INFO - blessings == 1.6 08:00:51 INFO - blobuploader == 1.2.4 08:00:51 INFO - docopt == 0.6.1 08:00:51 INFO - manifestparser == 1.1 08:00:51 INFO - mozInstall == 1.12 08:00:51 INFO - mozcrash == 0.17 08:00:51 INFO - mozdebug == 0.1 08:00:51 INFO - mozdevice == 0.48 08:00:51 INFO - mozfile == 1.2 08:00:51 INFO - mozhttpd == 0.7 08:00:51 INFO - mozinfo == 0.9 08:00:51 INFO - mozleak == 0.1 08:00:51 INFO - mozlog == 3.1 08:00:51 INFO - moznetwork == 0.27 08:00:51 INFO - mozprocess == 0.22 08:00:51 INFO - mozprofile == 0.28 08:00:51 INFO - mozrunner == 6.11 08:00:51 INFO - mozscreenshot == 0.1 08:00:51 INFO - mozsystemmonitor == 0.0 08:00:51 INFO - moztest == 0.7 08:00:51 INFO - mozversion == 1.4 08:00:51 INFO - psutil == 3.1.1 08:00:51 INFO - requests == 1.2.3 08:00:51 INFO - wsgiref == 0.1.2 08:00:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:00:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:51 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 0x7f72eabedf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b5b6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b561d0>, '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 0x1b59750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b59be0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1458225981.900297-611633519', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:00:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 08:00:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:00:51 INFO - Using env: {'DISPLAY': ':0', 08:00:51 INFO - 'HOME': '/home/cltbld', 08:00:51 INFO - 'LANG': 'en_US.UTF-8', 08:00:51 INFO - 'LANGUAGE': 'en_US:en', 08:00:51 INFO - 'LOGNAME': 'cltbld', 08:00:51 INFO - 'MAIL': '/var/mail/cltbld', 08:00:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:51 INFO - 'MOZ_NO_REMOTE': '1', 08:00:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:51 INFO - 'NO_EM_RESTART': '1', 08:00:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:00:51 INFO - 'PWD': '/builds/slave/test-pgo', 08:00:51 INFO - 'SHELL': '/bin/bash', 08:00:51 INFO - 'SHLVL': '1', 08:00:51 INFO - 'TERM': 'linux', 08:00:51 INFO - 'TMOUT': '86400', 08:00:51 INFO - 'USER': 'cltbld', 08:00:51 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1458225981.900297-611633519', 08:00:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:51 INFO - '_': '/tools/buildbot/bin/python'} 08:00:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 08:00:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 08:00:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 08:00:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 08:00:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 08:00:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 08:00:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 08:00:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 08:00:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 08:00:51 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 08:00:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 08:00:51 INFO - Cleaning up... 08:00:51 INFO - Return code: 0 08:00:51 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 08:00:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:51 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 0x7f72eabedf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b5b6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b561d0>, '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 0x1b59750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b59be0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1458225981.900297-611633519', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:00:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 08:00:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:00:51 INFO - Using env: {'DISPLAY': ':0', 08:00:51 INFO - 'HOME': '/home/cltbld', 08:00:51 INFO - 'LANG': 'en_US.UTF-8', 08:00:51 INFO - 'LANGUAGE': 'en_US:en', 08:00:51 INFO - 'LOGNAME': 'cltbld', 08:00:51 INFO - 'MAIL': '/var/mail/cltbld', 08:00:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:51 INFO - 'MOZ_NO_REMOTE': '1', 08:00:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:51 INFO - 'NO_EM_RESTART': '1', 08:00:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:00:51 INFO - 'PWD': '/builds/slave/test-pgo', 08:00:51 INFO - 'SHELL': '/bin/bash', 08:00:51 INFO - 'SHLVL': '1', 08:00:51 INFO - 'TERM': 'linux', 08:00:51 INFO - 'TMOUT': '86400', 08:00:51 INFO - 'USER': 'cltbld', 08:00:51 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1458225981.900297-611633519', 08:00:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:51 INFO - '_': '/tools/buildbot/bin/python'} 08:00:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:51 INFO - Downloading/unpacking jsonschema 08:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:00:53 INFO - Downloading/unpacking functools32 (from jsonschema) 08:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:53 INFO - Downloading functools32-3.2.3-2.tar.gz 08:00:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 08:00:53 INFO - warning: no files found matching '*.txt' 08:00:53 INFO - no previously-included directories found matching 'build' 08:00:53 INFO - no previously-included directories found matching 'dist' 08:00:53 INFO - no previously-included directories found matching '.git*' 08:00:53 INFO - Installing collected packages: jsonschema, functools32 08:00:53 INFO - Running setup.py install for functools32 08:00:54 INFO - warning: no files found matching '*.txt' 08:00:54 INFO - no previously-included directories found matching 'build' 08:00:54 INFO - no previously-included directories found matching 'dist' 08:00:54 INFO - no previously-included directories found matching '.git*' 08:00:54 INFO - Successfully installed jsonschema functools32 08:00:54 INFO - Cleaning up... 08:00:54 INFO - Return code: 0 08:00:54 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 08:00:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:54 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 0x7f72eabedf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b5b6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b561d0>, '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 0x1b59750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b59be0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1458225981.900297-611633519', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:00:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 08:00:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:00:54 INFO - Using env: {'DISPLAY': ':0', 08:00:54 INFO - 'HOME': '/home/cltbld', 08:00:54 INFO - 'LANG': 'en_US.UTF-8', 08:00:54 INFO - 'LANGUAGE': 'en_US:en', 08:00:54 INFO - 'LOGNAME': 'cltbld', 08:00:54 INFO - 'MAIL': '/var/mail/cltbld', 08:00:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:54 INFO - 'MOZ_NO_REMOTE': '1', 08:00:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:54 INFO - 'NO_EM_RESTART': '1', 08:00:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:00:54 INFO - 'PWD': '/builds/slave/test-pgo', 08:00:54 INFO - 'SHELL': '/bin/bash', 08:00:54 INFO - 'SHLVL': '1', 08:00:54 INFO - 'TERM': 'linux', 08:00:54 INFO - 'TMOUT': '86400', 08:00:54 INFO - 'USER': 'cltbld', 08:00:54 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1458225981.900297-611633519', 08:00:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:54 INFO - '_': '/tools/buildbot/bin/python'} 08:00:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:54 INFO - Downloading/unpacking flake8 08:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:00:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:00:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 08:00:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:00:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:00:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:00:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:00:57 INFO - no previously-included directories found matching 'docs/_build' 08:00:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:00:57 INFO - Running setup.py install for pep8 08:00:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:00:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:00:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:00:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:00:57 INFO - no previously-included directories found matching 'docs/_build' 08:00:57 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 08:00:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:00:57 INFO - Cleaning up... 08:00:57 INFO - Return code: 0 08:00:57 INFO - Running post-action listener: _resource_record_post_action 08:00:57 INFO - Running post-action listener: _start_resource_monitoring 08:00:57 INFO - Starting resource monitoring. 08:00:57 INFO - ##### 08:00:57 INFO - ##### Running install step. 08:00:57 INFO - ##### 08:00:57 INFO - Running pre-action listener: _resource_record_pre_action 08:00:57 INFO - Running main action method: install 08:00:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:00:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:00:57 INFO - Reading from file tmpfile_stdout 08:00:57 INFO - Detecting whether we're running mozinstall >=1.0... 08:00:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 08:00:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 08:00:57 INFO - Reading from file tmpfile_stdout 08:00:57 INFO - Output received: 08:00:57 INFO - Usage: mozinstall [options] installer 08:00:57 INFO - Options: 08:00:57 INFO - -h, --help show this help message and exit 08:00:57 INFO - -d DEST, --destination=DEST 08:00:57 INFO - Directory to install application into. [default: 08:00:57 INFO - "/builds/slave/test-pgo"] 08:00:57 INFO - --app=APP Application being installed. [default: firefox] 08:00:57 INFO - mkdir: /builds/slave/test-pgo/build/application 08:00:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 08:00:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 08:01:14 INFO - Reading from file tmpfile_stdout 08:01:14 INFO - Output received: 08:01:14 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 08:01:14 INFO - Running post-action listener: _resource_record_post_action 08:01:14 INFO - ##### 08:01:14 INFO - ##### Running run-tests step. 08:01:14 INFO - ##### 08:01:14 INFO - Running pre-action listener: _resource_record_pre_action 08:01:14 INFO - Running main action method: run_tests 08:01:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 08:01:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 08:01:14 INFO - Python 2.7.3 08:01:14 INFO - Return code: 0 08:01:14 INFO - grabbing minidump binary from tooltool 08:01:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:14 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 0x1b561d0>, '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 0x1b59750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b59be0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 08:01:14 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 08:01:14 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:01:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:01:14 INFO - Return code: 0 08:01:14 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 08:01:14 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 08:01:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 08:01:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 08:01:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 08:01:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 08:01:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 08:01:15 INFO - Return code: 0 08:01:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bughPZShQsyLYBaiDoWKqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 08:01:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bughPZShQsyLYBaiDoWKqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 08:01:15 INFO - Using env: {'DISPLAY': ':0', 08:01:15 INFO - 'HOME': '/home/cltbld', 08:01:15 INFO - 'LANG': 'en_US.UTF-8', 08:01:15 INFO - 'LANGUAGE': 'en_US:en', 08:01:15 INFO - 'LOGNAME': 'cltbld', 08:01:15 INFO - 'MAIL': '/var/mail/cltbld', 08:01:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:01:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 08:01:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:15 INFO - 'MOZ_NO_REMOTE': '1', 08:01:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:01:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:01:15 INFO - 'NO_EM_RESTART': '1', 08:01:15 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:01:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:01:15 INFO - 'PWD': '/builds/slave/test-pgo', 08:01:15 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 08:01:15 INFO - 'SHELL': '/bin/bash', 08:01:15 INFO - 'SHLVL': '1', 08:01:15 INFO - 'TERM': 'linux', 08:01:15 INFO - 'TMOUT': '86400', 08:01:15 INFO - 'USER': 'cltbld', 08:01:15 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1458225981.900297-611633519', 08:01:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:15 INFO - '_': '/tools/buildbot/bin/python'} 08:01:15 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bughPZShQsyLYBaiDoWKqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:01:15 INFO - mozversion application_buildid: 20160317053013 08:01:15 INFO - mozversion application_changeset: 21b7869572c92dab8d9fa07d333c43f2855a1b3b 08:01:15 INFO - mozversion application_display_name: Nightly 08:01:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:01:15 INFO - mozversion application_name: Firefox 08:01:15 INFO - mozversion application_remotingname: firefox 08:01:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:01:15 INFO - mozversion application_vendor: Mozilla 08:01:15 INFO - mozversion application_version: 48.0a1 08:01:15 INFO - mozversion platform_buildid: 20160317053013 08:01:15 INFO - mozversion platform_changeset: 21b7869572c92dab8d9fa07d333c43f2855a1b3b 08:01:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:01:15 INFO - mozversion platform_version: 48.0a1 08:01:15 INFO - using testdate: 1458226875 08:01:15 INFO - actual date: 1458226875 08:01:15 INFO - starting webserver on 'localhost:56887' 08:01:15 INFO - SUITE-START | Running 2 tests 08:01:15 INFO - TEST-START | dromaeo_css 08:01:15 INFO - operating with platform_type : linux_ 08:01:15 INFO - Initialising browser for dromaeo_css test... 08:01:15 INFO - TEST-INFO | started process 29192 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmplV0Bbm/profile http://localhost:56887/getInfo.html) 08:01:19 INFO - PROCESS | 29192 | __metrics Screen width/height:1600/1200 08:01:19 INFO - PROCESS | 29192 | colorDepth:24 08:01:19 INFO - PROCESS | 29192 | Browser inner width/height: 1024/697 08:01:19 INFO - PROCESS | 29192 | __metrics 08:01:20 ERROR - PROCESS | 29192 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:01:21 INFO - TEST-INFO | 29192: exit 0 08:01:21 INFO - Browser initialized. 08:01:21 INFO - Running cycle 1/1 for dromaeo_css test... 08:01:21 INFO - TEST-INFO | started process 29283 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmplV0Bbm/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:01:33 INFO - PROCESS | 29283 | RSS: Main: 153276416 08:01:33 INFO - PROCESS | 29283 | 08:02:24 INFO - PROCESS | 29283 | 1458226944570 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:04:31 INFO - PROCESS | 29283 | Cycle 1(1): loaded http://localhost:56887/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56887/tests/dromaeo/cssquery-ext.html) 08:04:32 INFO - PROCESS | 29283 | RSS: Main: 268320768 08:04:32 INFO - PROCESS | 29283 | 08:07:34 INFO - PROCESS | 29283 | Cycle 1(1): loaded http://localhost:56887/tests/dromaeo/cssquery-ext.html (next: http://localhost:56887/tests/dromaeo/cssquery-jquery.html) 08:07:35 INFO - PROCESS | 29283 | RSS: Main: 234991616 08:07:35 INFO - PROCESS | 29283 | 08:10:36 INFO - PROCESS | 29283 | Cycle 1(1): loaded http://localhost:56887/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56887/tests/dromaeo/cssquery-mootools.html) 08:10:37 INFO - PROCESS | 29283 | RSS: Main: 242229248 08:10:37 INFO - PROCESS | 29283 | 08:13:39 INFO - PROCESS | 29283 | Cycle 1(1): loaded http://localhost:56887/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56887/tests/dromaeo/cssquery-prototype.html) 08:13:39 INFO - PROCESS | 29283 | RSS: Main: 221769728 08:13:39 INFO - PROCESS | 29283 | 08:16:42 INFO - PROCESS | 29283 | Cycle 1(1): loaded http://localhost:56887/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56887/tests/dromaeo/cssquery-yui.html) 08:16:42 INFO - PROCESS | 29283 | RSS: Main: 223428608 08:16:43 INFO - PROCESS | 29283 | 08:19:45 INFO - PROCESS | 29283 | Cycle 1(1): loaded http://localhost:56887/tests/dromaeo/cssquery-yui.html (next: http://localhost:56887/tests/dromaeo/cssquery-dojo.html) 08:19:45 INFO - PROCESS | 29283 | RSS: Main: 293285888 08:19:45 INFO - PROCESS | 29283 | 08:19:45 INFO - PROCESS | 29283 | __start_tp_report 08:19:45 INFO - PROCESS | 29283 | _x_x_mozilla_page_load 08:19:45 INFO - PROCESS | 29283 | _x_x_mozilla_page_load_details 08:19:45 INFO - PROCESS | 29283 | |i|pagename|runs| 08:19:45 INFO - PROCESS | 29283 | |0;dojo.html;3038.939221215576;3067.6318841738994;3110.1447102046936;3116.283254851383;3144.0253521408367;5130.179171332587;5194.376674799029;5206.713630750307;5249.055170069386;5286.788528458862;5163.690178589287;5174.404943431507;5182.11903976324;5197.220416937452;5304.867378315544;4668.25307950728;4681.812727490905;4797.90404191916;4851.22380419133;4861.052094841507;4615.446146462429;4763.61891048717;4807.807687692488;4813.446453657822;4908.190148625473;4738.052389522092;4744.312074749159;4750.45369782476;4768.570828625423;4800.855974320741;4740.265258884879;4743.075100355432;4757.5718185363485;4769.928451073237;4773.618110551148;4628.421447319085;4676.2050451423;4690.038542098861;4711.835085772016;4714.222153344694;4979.551840334351;4994.35073440454;4995.60035197187;4998.475160108209;5002.099622068026;5451.672899625995;5455.454454554552;5456.317960254968;5493.972530137324;5580.051391263495;5597.384287728347;5602;5602.60781745278;5604.047311956977;5630.324361076656;5229.947700523022;5265;5268.473152684739;5270.39390470097;5271.42014378418;5553.777848885999;5662.094064949588;5738.110592858114;5763.567732420085;5819.679917604488;5526.005319042611;5571.749271282802;5571.832845014656;5578.386377498472;5599.720013999284;5627.803026894039;5727.7422515986045;5728.856778580569;5734.455226753452;5735.11105778605;5462.9726851365485;5569.415211402745;5625.606207565513;5693.430656934356;5704.743286552115;5627.8874422512135;5633.943660563424;5638.182463542846;5639.182318563785;5642.463965923313;4287.506936702319;4310.482742070909;4317.8272869084885;4319.935200971988;4350.456192975878;3718.2563487302646;3778.4899038629983;3829.3107240696386;3857.594952529944;3871.96128038716;5325.201219817059;5327.360716713942;5331.306930099062;5344.038073146793;5371.677699338053;5572.414896435897;5648.51987581052;5649.519790817826;5655.095184770417;5655.293088363955;5253.684778913277;5254.868628284247;5266.262723218752;5307.681539107666;5325.866853328698;4651.720896746206;4657.208274593259;4660.790264438108;4673.60274376675;4708.764561771898;5701.116326969326;5792.623479473905;5794.594378393556;5796.942030579725;5797.681127537941;5549.805756798573;5595.740958284354;5606.159076138611;5607.80372686954;5645.604807663589;5797.9420205797405;5836.328822185503;5838.4453476919625;5848.093545500455;5848.356680765198;5434.049041417815;5479.698616575967;5508.283923089973;5540.36285827135;5556.444355564573;5601.719914004202;5603;5605.299337582802;5631.0427227372265;5656.3495198051105;5453.2365468833605;5493.423190564933;5496.6701997880255;5499.340079190522;5499.945000549943;5393.83818485446;5472.2338872557075;5492.093804522209;5522.641028333145;5581.720913954205;5409.377921539073;5435.673859568438;5438.15708565173;5439.728013599225;5464.535514481314;5526.80656177048;5528.44715528444;5531.9723401382735;5545.140503222007;5604.607677462538;5200.115980283285;5267.209918512254;5315.813946511854;5383.380911195262;5416.8104116355735 08:19:45 INFO - PROCESS | 29283 | |1;ext.html;552.6979515158973;567.6225310168741;570.3982298674896;574.3366411794377;591.8165368735691;39492.40761388578;39787;39793.60206397935;39806.40290395646;39826.80086599563;42257.36613950785;42856.785716071456;42886.57113428865;42900.57099429005;42933.35599966003;8728.650853965833;8908.420952638058;8929.598168082419;8932.33007524435;8936.061713520085;8744;8810.383273170848;8864.778380540474;8866.822663546725;8876.112388761137;9132.08679132088;9155.54222288883;9197.448153110834;9206.631734730636;9208.539573021322;8988.550572471382;9032;9041.276697864188;9048.140426659456;9055;8923.955380223057;9031.412958157698;9041.412308199946;9050.637974481013;9071.546422678839;42534;43062.354064689054;43065.13869722619;43076.13847723059;43136.352954705704;3249.496328069153;3457.94813077804;3714.238581090897;3874.8450061997487;4388.166248412791;30553.23616909573;31165.37669246625;31252;31425.528617070762;31594;4279.1382070172085;4309.6336811371075;4326.394304797331;4335.5456859124515;4361.934570981438;318960;327307;327375;327448;328307;66572.66713666498;67554.66222668953;68140.6592967042;68271;68298;71766;72628.63685681538;72633.27366726265;72634;72900;15946.362145514282;16238.431654892021;16257.268422920997;16280.26738796757;16287;12085.093617978686;12088.03295736339;12145.271283722828;12146.210496317712;12148.21036632616;22135.557288854456;22308.442288942908;22352;22515.099396023976;22537.43656408603;8639.611217495229;8933.910660893307;8997.325200609981;9013.414128081786;9138.268938484905;1030.4229631406436;1106.4578356605205;1115.9721006974728;1125.4372813593204;1235.1415766042694;31835.68164318327;33067.338653227285;33407.3318533628;33425.164370890925;33732.156696082304;1108.9279196852178;1132.5186795611833;1164.4527072276016;1196.2583198416862;1243.2167734327315;16908.32366705318;17259.13704314779;17323.740143897852;17327.22027508765;17492.562685932953;790196;797869;800127;803547;805236;58979.410205897395;60283.69858150769;60322.39677603168;60422.09366859501;60488.395116049156;1240.3178251961385;1330.1885849631717;1395.8813500852339;1416.773316269392;1450.0574626492864;30740.84814062994;32374.83812580922;32482.51276230811;32704.67295327016;32842.67157328396;45021.77489112534;45612.315815263464;46192.30711539262;46307.3053904185;46374.53625463837;283564;284543;285022;285833;286162;31653.050408487783;36235.27529449343;36364.27271454609;36504;36790.63209367872;43361.566384335754;43485.130297394506;43558.128837423705;43793.343099854166;43805.56194438015;36027.459588105674;36538;36730.4490432649;36759.448608271436;37125.443118352705;35963.28073438464;36618.63381366152;36700.26599468049;37052.62947370492;37327.81336093302;36461.635383646884;38596.42105368478;40835;41057.79471102745;41164.38253426261;32537.511937321433;34934.82532587321;35224.64775352316;35227;35258.294834102664;27588.586171207047;27629.30926726848;27963.580546291414;28004.57993130064;28259.576106358832 08:19:45 INFO - PROCESS | 29283 | |2;jquery.html;359.5361983041876;364.45695913089503;366.53816191598594;366.80192695944186;381.27177091754754;17204.65590688187;17290.827091729094;18070.4578862634;18079.548011299725;18098.99999999998;16532.66934661306;17625.47123586291;17645.55886102848;17661.91169044156;17668.116594170304;4654.301854721785;4880.023995200974;4881.1213981483315;4885.120678277908;4889.755512224392;3876.030992251937;4804.591609713161;5328.5470734987575;5516.724163791814;5551.084071128259;5517.475839795213;5523.7790488380415;5528.723563821813;5532.6680399175975;5538.418466061066;5354.625176237665;5473.507384335389;5511.53151982082;5541.445855414467;5555.666660000393;5318.547923426513;5318.946810531884;5342.759575819097;5349.625526213128;5353.491418315292;13075.084744067919;13447.125936814173;13495.460181592725;13496.325183740773;13496.595102146952;2173.5435558532727;2179.9128034878586;2283.977160228393;2302.435903203709;2413.0589070262613;9539.14147726708;9572.904270957271;9804.705858824176;9944.35361701487;9954.751131221705;1938.8255057044935;1949.6198241342943;2010.5677279384856;2016.4152395805345;2029.4723371923405;64487;71303.99999999948;71801;71868.28131718669;72341;10730.087942524973;10757.354558726502;10989.99999999984;10994.230403871652;11169;14127.434902603985;14152.22162781057;14282.21447820359;14301.713965720628;14308.785368219485;7693;8007;8013.7996550085545;8100.756977290691;8161.061477930114;7797.610119494003;7805.258500442449;7839.059312882377;7938.206179382016;7987.9201207988335;4637.003044345414;4642.141203877293;4649.721016739007;4653.395058642355;4722.527747225318;1760.9295628174987;1820.6904826179582;1844.483544607485;1872.2230274435956;1882.341180586811;989.2778271861581;1014.6651604970342;1078.2883297023927;1086.473060565625;1127.447550700151;17023;17199.1400429978;17368.39210627622;17571.56071098233;17733.29066837312;1019.3700253346349;1023.7901230247782;1064.7125276175389;1065.6909496246158;1078.2182917384832;8059.791031345345;10297.794044119075;10388.272820902615;10576.52405641748;10646.20153488476;484137;489773;498344;509737;510851;79752.60123699345;80360.59819700864;80835.19164808394;81206;81786;1021.6577446555339;1030.8093002794508;1041.1306559023149;1045.257866914484;1046.2048842879467;15996.280167392262;16064.67870642604;16106.597335066717;16224.35102595883;16402.687784976933;34680.13299667528;34933.301333973686;35420.645793541735;35485.467717984764;35878;47445.17888993787;50963.49036509736;51155.744221278655;51510.48489515207;52114.218286726486;8050.993625796776;8119.147489513753;8145.42981991255;8390.958045209734;8418.452800567944;9441.055894410503;12572.497100115894;12947.61157165249;12972.545960891324;12996.220226786423;11255.493502792559;11500.654980350602;11601.825972610586;11690.532378704756;11818.290902545874;11060.56212692377;11064.22550421495;11267.661970140909;11338.206325557132;11425.657230283105;11506.712332191762;11744.471498782405;11756.647300580997;11757.412129393668;11926.701832454259;8084.636191371284;8123.7969050771835;8191.549464779494;8254.968128983877;8356.373272004746;11281.153913456359;11519.654410367702;11552.364619945984;11652.242604230698;11702.824457632973 08:19:45 INFO - PROCESS | 29283 | |3;mootools.html;1240.1938739819122;1463.7584798508246;1469.3902030657277;1663.376233912283;1839.8252166044222;7876.1730018348035;8057.758267251985;8071.596420178997;8071.6367763450635;8121.756347309575;7931.127575966639;8067.47561408508;8073.959630201855;8094.352451803857;8108.472949258309;2037.5924815036979;2294.701688780456;2303.378087916266;2334.708161479815;2346.3195673254736;2335.871527066011;2340.4733934864603;2343.4610039690883;2344.308429013445;2344.9296521104393;2222.4777177363308;2274.533720587284;2279.726432828063;2279.817614590837;2280.9657855132186;2295.288460577218;2317.142657216824;2379.7382287948312;2385.940351491209;2391.2228525729206;2330.1378489958656;2337.135259953828;2337.6026075567192;2348.2602980061224;2349.1543044504137;8246.793830154234;8322.62548185333;8324.542150181738;8326.375521835887;8326.583670816435;5021.748912554394;5137.845864624067;5140.897182056338;5142.614303927183;5143.691378517264;3239.9838000809846;3327.2014716467875;3400.60892997306;3432.1248081739245;3438.862445502177;1094.7263184203948;1132.8697199822043;1138.408027825526;1147.4033502578613;1153.4924633161465;11379.829302560469;11440.313581185155;11514.769704605944;11515.827262591069;11517.654470365902;4496.977515112403;4584.679072464962;4600.056988317387;4600.35595016698;4627.652926030494;9771.51142442875;9839.311248212556;9840;9840.65557705477;9846.803063938682;4546.0680560485025;5107.846764597068;5117.513836185556;5119.924815788726;5133.23001549763;4564.6348292136545;4615.953840461552;4670.673052886265;4671.85984420468;4685.0395668887795;3933.272344616198;3990.20195960809;3993.72043956926;4026.074002979273;4040.010197501631;1232.648695121886;1236.110000799441;1241.5530409052733;1242.5278394210143;1247.2765795838393;1380.4064252371377;1382.8340599128169;1403.2632867744517;1415.3984556563419;1417.149710173908;7919.841603167904;8096.190380961857;8109.878351824727;8116.066652334939;8120;488.35780948053196;495.5391485918059;497.69391824028685;501.52856315063724;501.59621504688346;6078.331383547807;6086.482648974798;6098.634081955097;6175.2898416681755;6179.5056395488255;9315.208207302456;9505.809883802423;9697.757556061155;9720.61117555304;9809.803803924024;9431.764205894908;9679.70960871175;9712.17446517054;9728.075832795874;9764.853527197098;7763.573003484749;7889.289963903277;7896.921030789734;7958.522488650699;7961.40289478303;7815.218478152139;7845.9215407845195;7947.284744373034;7955.323797477279;7960.6417711201975;8856.424332418372;8978.191962723386;9110.90889091127;9158.358914875895;9264.44413335202;9242.214411775074;9242.445453272825;9331.486768227813;9333.439993600407;9361.625534978524;6498.317676643885;6676.766313179015;7055.6472176392;7335.8532829344185;7444.962775186089;7860.410469214946;7867.606619669108;7869.3311068559815;7909.1695371985115;7917.683292668229;6860.936554834008;6989.615571143432;6990.776614092615;7065.22282548909;7186.820329491805;7164.9641751790905;7187.173475050227;7224.169220539495;7228.96385518069;7291.562506249642;7376.4836461447185;7642.121156067124;7644.961775191088;7650.885236721565;7653.311201991847;6930.064441300561;6940.063091482585;6954.200266969363;6960.443164546723;6963.1296087989;6992;7061.1173603299585;7079.327463890922;7100.4319654428555;7102.325279098477 08:19:45 INFO - PROCESS | 29283 | |4;prototype.html;342.0644537190783;342.8731369393325;344.0469898381482;345.31110434682813;354.22424889492027;5888.7644494220285;5931.85170370741;5956.642601443911;5958.404159584039;5963.522918166547;5838.532917366611;5840.445157710011;5843.094320380337;5847.327557330908;5860.76556937723;4380.145871555048;4404.603585677289;4489.1919454498175;4549.613282870943;4557.270836666125;4522.796474158671;4526.6831321807485;4533.093381323732;4545.863624091266;4548.022175232324;4492.460904691426;4493.9775301123445;4501.932471012921;4504.301833215841;4506.729596224237;4372.27857403528;4447.3996010538485;4494.258447356182;4509.323601459807;4511.571400716926;3982.183652351261;3988.4017397390335;3992;3992.301347264217;3996.3406038003695;5678.801241956512;5739.512141467981;5742.2247996520355;5745.511631511326;5746.281714785652;5337.866553336197;5342.519173274385;5343.545798607084;5343.62594618373;5364.22218778275;6268.561200715906;6272.780452684134;6275.7489700411925;6275.811725648238;6277.4664153547;4369.47566292047;4465;4471.485779135409;4532.4334458192725;4537.954620453819;6513.739450421977;6552.213734351861;6597.076409302702;6598.802035938881;6658;4504.166729155117;4541.364209010741;4544.727316361029;4545.204589196877;4549.181147393435;4612.262038073892;4614.8384806532285;4615.815367385267;4623.075384923029;4626.907461850744;5282.841514754564;5286.920696189561;5288.550473209743;5292.179712144623;5292.788288468418;6244.313125556185;6357.745690172342;6366.4588509977175;6390.680465976682;6391.1371964785085;1638.901665900026;1648.7609296651917;1656.577572718973;1659.1621231278127;1662.6009757658076;1069.1126365116934;1112.7440688641657;1119.809632362484;1128.9435528223555;1149.494222542079;5974.492168165668;6007.609505382136;6027.57806953509;6061.515078793686;6122.357152498924;6423.454006409507;6427.517936154807;6431.935680643227;6457.7094030767785;6515.348465153542;6032.698365081728;6040.939590604038;6045.72794224261;6045.969770151121;6047.576669633171;3460.9307813843584;3492.7031202348085;3496.1084923344383;3498.1429549760473;3498.772579782306;6542.6401547914365;6715.664216789141;6717.026031225445;6723.596584204964;6724.562903411263;6599.60402375859;6605.009248612747;6625.337466253336;6628.734850605922;6635.568688035262;6703.061571380011;6718.899216511756;6719.462443004548;6779.186497620317;6786.389224969677;6421.775237866652;6473.320301368289;6475.061116138039;6493.577917435352;6497.837554061186;6300.905486417799;6372.203474565679;6396.840078998062;6507;6510.18622672166;6729.528932974645;6807.523473356818;6813.7615183470325;6816.386525212754;6834.487413444111;4451.977740111279;4477.619402350837;4479.3057076153245;4480.484744254452;4487.910241795081;6565.441937435371;6576.0464732612545;6582.76960306387;6585.242697089896;6588.505862060269;6280.874382512416;6415.743370265137;6416.13382193398;6417.326180750954;6429.196350456193;6328.398802113792;6360.077788720702;6376.585521941059;6382.840428989312;6383.106365108795;6295.811125666238;6300.369963003663;6305.274893387319;6305.873882522232;6306.810795676137;6413.230412350548;6448.419642232222;6448.742050317935;6449.838754030999;6460.289368169404;5891.882162356643;5997.280326360865;6098.146259523582;6285.779997700059;6286.968565157328 08:19:45 INFO - PROCESS | 29283 | |5;yui.html;732.9560226386417;773.5436092705303;822.9958850205749;844.1853611265132;856.6530555125177;13399.263040532778;13503.66240843978;13539.932300338496;15697.058176509418;15701.685966280667;14358.569242922704;14431.639209019753;14433.206173660445;14475.710485790278;14489.130652160879;671.8253254153931;682.379035078079;819.5615345789988;821.6959724901794;832.4048305461594;836.9832603347929;838.0613712641849;840.5587066789923;841.7222316635496;841.7769291137823;880.5113162194979;884.054062153496;884.2969838977996;884.752269364579;885.3404213860683;707.6072779607316;858.858288382413;870.9912900870974;871.8430682477151;873.7946582553095;631.7062565906875;632.3139393757779;632.4244937107256;633.1262857256955;634.0647544871324;13820.37808298629;13859.099158554662;13929.86070139306;13935.303234838319;13938.651533711636;13218.008649351337;13501.277511318318;13550.254735989516;13663.248521331323;13681.110727802661;12022.819657705142;12169.330686812222;12296;12372.13395062346;12507.312097834707;3851.5570709368503;3979.3633018717155;4012.799360031987;4029.254587901218;4041.7777022263763;51076.48923510755;51291.743541282056;51505.22742158871;51812.48187518152;51967.48032519702;11095.722606934729;11134.832977505344;11235.83146252807;11389.829152562717;11454.770904581861;20720.792792071887;20735;20737.377878663665;20764.480887977923;20788.896055519624;8170.509769413854;8450.661973521113;8534.146585341416;8608.612612432331;8710.82578348442;4634;4674.485806561275;4770.952290477051;4777.546133117348;4785.808567657325;3390.69483746464;3433.4678124890684;3434.278801451723;3434.862605495802;3450.879219227315;568.778176511161;603.0532064658444;603.7584966013629;606.3481757111123;658.2989116590816;540.394757871179;586.7502220270881;629.8897692903815;631.324482803396;701.6456689371937;8322.958385208036;8669.21977022071;8700.738977830675;8825.955870220736;8995.595198216097;547.6495043172373;628.531743850834;669.7053296549502;697.3723648716197;699.8845190543503;4136.358864376027;4196.181744559843;4244.3633454982;4299.634531064895;4430.224710675619;55493.72253138709;66005.66997164984;66527;66679.66660166669;71029;52748.736256319244;53238;53493.732531337875;53658;54184.72907635516;49964.250536241256;50059.74970125199;50105.49894501081;50376;51130;9494.620215191315;9711.223102151953;9727.805443891224;9858.704238872846;9865.654702085392;36695.26609467742;37615.43576846295;38122;38435.6156438432;38827.805860971646;45073;48482;48585.5141448581;49353;49476.50523494719;11848.76302473963;11950.282983021047;12001.1599188056;12211.26732396059;12229.510819567118;13449.260290684106;13484.190948543119;13541.526046588322;13572.1856688599;13594.048416610742;12648.74702505963;12783.296918669563;12828.871711282767;12910.289934053717;12973.610791676265;12265.877341226831;12336.876631233932;12679.366031698562;13260.668483287995;13382.330883455983;11972.461239244081;12000.57997970067;12449.190802597803;12540.87459125397;13147.671308217372;10120.746981325527;10609.575616975235;11003.504842281956;11212.887871121184;11662.416879156179;10555.313904596484;10606.151507879506;10786.460676966277;10788.083012943674;10824.621138260123 08:19:45 INFO - PROCESS | 29283 | __end_tp_report 08:19:45 INFO - PROCESS | 29283 | __start_cc_report 08:19:45 INFO - PROCESS | 29283 | _x_x_mozilla_cycle_collect,859 08:19:45 INFO - PROCESS | 29283 | __end_cc_report 08:19:45 INFO - PROCESS | 29283 | __startTimestamp1458227985880__endTimestamp 08:19:45 INFO - PROCESS | 29283 | 08:19:45 INFO - PROCESS | 29283 | ------- Summary: start ------- 08:19:45 INFO - PROCESS | 29283 | Number of tests: 6 08:19:45 INFO - PROCESS | 29283 | 08:19:45 INFO - PROCESS | 29283 | [#0] dojo.html Cycles:165 Average:5197.80 Median:5434.05 stddev:593.38 (10.9%) stddev-sans-first:570.52 08:19:45 INFO - PROCESS | 29283 | Values: 3038.9 3067.6 3110.1 3116.3 3144.0 5130.2 5194.4 5206.7 5249.1 5286.8 5163.7 5174.4 5182.1 5197.2 5304.9 4668.3 4681.8 4797.9 4851.2 4861.1 4615.4 4763.6 4807.8 4813.4 4908.2 4738.1 4744.3 4750.5 4768.6 4800.9 4740.3 4743.1 4757.6 4769.9 4773.6 4628.4 4676.2 4690.0 4711.8 4714.2 4979.6 4994.4 4995.6 4998.5 5002.1 5451.7 5455.5 5456.3 5494.0 5580.1 5597.4 5602.0 5602.6 5604.0 5630.3 5229.9 5265.0 5268.5 5270.4 5271.4 5553.8 5662.1 5738.1 5763.6 5819.7 5526.0 5571.7 5571.8 5578.4 5599.7 5627.8 5727.7 5728.9 5734.5 5735.1 5463.0 5569.4 5625.6 5693.4 5704.7 5627.9 5633.9 5638.2 5639.2 5642.5 4287.5 4310.5 4317.8 4319.9 4350.5 3718.3 3778.5 3829.3 3857.6 3872.0 5325.2 5327.4 5331.3 5344.0 5371.7 5572.4 5648.5 5649.5 5655.1 5655.3 5253.7 5254.9 5266.3 5307.7 5325.9 4651.7 4657.2 4660.8 4673.6 4708.8 5701.1 5792.6 5794.6 5796.9 5797.7 5549.8 5595.7 5606.2 5607.8 5645.6 5797.9 5836.3 5838.4 5848.1 5848.4 5434.0 5479.7 5508.3 5540.4 5556.4 5601.7 5603.0 5605.3 5631.0 5656.3 5453.2 5493.4 5496.7 5499.3 5499.9 5393.8 5472.2 5492.1 5522.6 5581.7 5409.4 5435.7 5438.2 5439.7 5464.5 5526.8 5528.4 5532.0 5545.1 5604.6 5200.1 5267.2 5315.8 5383.4 5416.8 08:19:45 INFO - PROCESS | 29283 | 08:19:45 INFO - PROCESS | 29283 | [#1] ext.html Cycles:180 Average:62982.15 Median:21683.63 stddev:141695.66 (653.5%) stddev-sans-first:142015.63 08:19:45 INFO - PROCESS | 29283 | Values: 552.7 567.6 570.4 574.3 591.8 39492.4 39787.0 39793.6 39806.4 39826.8 42257.4 42856.8 42886.6 42900.6 42933.4 8728.7 8908.4 8929.6 8932.3 8936.1 8744.0 8810.4 8864.8 8866.8 8876.1 9132.1 9155.5 9197.4 9206.6 9208.5 8988.6 9032.0 9041.3 9048.1 9055.0 8924.0 9031.4 9041.4 9050.6 9071.5 42534.0 43062.4 43065.1 43076.1 43136.4 3249.5 3457.9 3714.2 3874.8 4388.2 30553.2 31165.4 31252.0 31425.5 31594.0 4279.1 4309.6 4326.4 4335.5 4361.9 318960.0 327307.0 327375.0 327448.0 328307.0 66572.7 67554.7 68140.7 68271.0 68298.0 71766.0 72628.6 72633.3 72634.0 72900.0 15946.4 16238.4 16257.3 16280.3 16287.0 12085.1 12088.0 12145.3 12146.2 12148.2 22135.6 22308.4 22352.0 22515.1 22537.4 8639.6 8933.9 8997.3 9013.4 9138.3 1030.4 1106.5 1116.0 1125.4 1235.1 31835.7 33067.3 33407.3 33425.2 33732.2 1108.9 1132.5 1164.5 1196.3 1243.2 16908.3 17259.1 17323.7 17327.2 17492.6 790196.0 797869.0 800127.0 803547.0 805236.0 58979.4 60283.7 60322.4 60422.1 60488.4 1240.3 1330.2 1395.9 1416.8 1450.1 30740.8 32374.8 32482.5 32704.7 32842.7 45021.8 45612.3 46192.3 46307.3 46374.5 283564.0 284543.0 285022.0 285833.0 286162.0 31653.1 36235.3 36364.3 36504.0 36790.6 43361.6 43485.1 43558.1 43793.3 43805.6 36027.5 36538.0 36730.4 36759.4 37125.4 35963.3 36618.6 36700.3 37052.6 37327.8 36461.6 38596.4 40835.0 41057.8 41164.4 32537.5 34934.8 35224.6 35227.0 35258.3 27588.6 27629.3 27963.6 28004.6 28259.6 08:19:45 INFO - PROCESS | 29283 | 08:19:45 INFO - PROCESS | 29283 | [#2] jquery.html Cycles:180 Average:27603.13 Median:2357.75 stddev:81800.59 (3469.4%) stddev-sans-first:82004.48 08:19:45 INFO - PROCESS | 29283 | Values: 359.5 364.5 366.5 366.8 381.3 17204.7 17290.8 18070.5 18079.5 18099.0 16532.7 17625.5 17645.6 17661.9 17668.1 4654.3 4880.0 4881.1 4885.1 4889.8 3876.0 4804.6 5328.5 5516.7 5551.1 5517.5 5523.8 5528.7 5532.7 5538.4 5354.6 5473.5 5511.5 5541.4 5555.7 5318.5 5318.9 5342.8 5349.6 5353.5 13075.1 13447.1 13495.5 13496.3 13496.6 2173.5 2179.9 2284.0 2302.4 2413.1 9539.1 9572.9 9804.7 9944.4 9954.8 1938.8 1949.6 2010.6 2016.4 2029.5 64487.0 71304.0 71801.0 71868.3 72341.0 10730.1 10757.4 10990.0 10994.2 11169.0 14127.4 14152.2 14282.2 14301.7 14308.8 7693.0 8007.0 8013.8 8100.8 8161.1 7797.6 7805.3 7839.1 7938.2 7987.9 4637.0 4642.1 4649.7 4653.4 4722.5 1760.9 1820.7 1844.5 1872.2 1882.3 989.3 1014.7 1078.3 1086.5 1127.4 17023.0 17199.1 17368.4 17571.6 17733.3 1019.4 1023.8 1064.7 1065.7 1078.2 8059.8 10297.8 10388.3 10576.5 10646.2 484137.0 489773.0 498344.0 509737.0 510851.0 79752.6 80360.6 80835.2 81206.0 81786.0 1021.7 1030.8 1041.1 1045.3 1046.2 15996.3 16064.7 16106.6 16224.4 16402.7 34680.1 34933.3 35420.6 35485.5 35878.0 47445.2 50963.5 51155.7 51510.5 52114.2 8051.0 8119.1 8145.4 8391.0 8418.5 9441.1 12572.5 12947.6 12972.5 12996.2 11255.5 11500.7 11601.8 11690.5 11818.3 11060.6 11064.2 11267.7 11338.2 11425.7 11506.7 11744.5 11756.6 11757.4 11926.7 8084.6 8123.8 8191.5 8255.0 8356.4 11281.2 11519.7 11552.4 11652.2 11702.8 08:19:45 INFO - PROCESS | 29283 | 08:19:45 INFO - PROCESS | 29283 | [#3] mootools.html Cycles:180 Average:5782.43 Median:6587.54 stddev:3032.65 (46.0%) stddev-sans-first:3021.94 08:19:45 INFO - PROCESS | 29283 | Values: 1240.2 1463.8 1469.4 1663.4 1839.8 7876.2 8057.8 8071.6 8071.6 8121.8 7931.1 8067.5 8074.0 8094.4 8108.5 2037.6 2294.7 2303.4 2334.7 2346.3 2335.9 2340.5 2343.5 2344.3 2344.9 2222.5 2274.5 2279.7 2279.8 2281.0 2295.3 2317.1 2379.7 2385.9 2391.2 2330.1 2337.1 2337.6 2348.3 2349.2 8246.8 8322.6 8324.5 8326.4 8326.6 5021.7 5137.8 5140.9 5142.6 5143.7 3240.0 3327.2 3400.6 3432.1 3438.9 1094.7 1132.9 1138.4 1147.4 1153.5 11379.8 11440.3 11514.8 11515.8 11517.7 4497.0 4584.7 4600.1 4600.4 4627.7 9771.5 9839.3 9840.0 9840.7 9846.8 4546.1 5107.8 5117.5 5119.9 5133.2 4564.6 4616.0 4670.7 4671.9 4685.0 3933.3 3990.2 3993.7 4026.1 4040.0 1232.6 1236.1 1241.6 1242.5 1247.3 1380.4 1382.8 1403.3 1415.4 1417.1 7919.8 8096.2 8109.9 8116.1 8120.0 488.4 495.5 497.7 501.5 501.6 6078.3 6086.5 6098.6 6175.3 6179.5 9315.2 9505.8 9697.8 9720.6 9809.8 9431.8 9679.7 9712.2 9728.1 9764.9 7763.6 7889.3 7896.9 7958.5 7961.4 7815.2 7845.9 7947.3 7955.3 7960.6 8856.4 8978.2 9110.9 9158.4 9264.4 9242.2 9242.4 9331.5 9333.4 9361.6 6498.3 6676.8 7055.6 7335.9 7445.0 7860.4 7867.6 7869.3 7909.2 7917.7 6860.9 6989.6 6990.8 7065.2 7186.8 7165.0 7187.2 7224.2 7229.0 7291.6 7376.5 7642.1 7645.0 7650.9 7653.3 6930.1 6940.1 6954.2 6960.4 6963.1 6992.0 7061.1 7079.3 7100.4 7102.3 08:19:45 INFO - PROCESS | 29283 | 08:19:45 INFO - PROCESS | 29283 | [#4] prototype.html Cycles:180 Average:5291.74 Median:5969.01 stddev:1585.37 (26.6%) stddev-sans-first:1545.67 08:19:45 INFO - PROCESS | 29283 | Values: 342.1 342.9 344.0 345.3 354.2 5888.8 5931.9 5956.6 5958.4 5963.5 5838.5 5840.4 5843.1 5847.3 5860.8 4380.1 4404.6 4489.2 4549.6 4557.3 4522.8 4526.7 4533.1 4545.9 4548.0 4492.5 4494.0 4501.9 4504.3 4506.7 4372.3 4447.4 4494.3 4509.3 4511.6 3982.2 3988.4 3992.0 3992.3 3996.3 5678.8 5739.5 5742.2 5745.5 5746.3 5337.9 5342.5 5343.5 5343.6 5364.2 6268.6 6272.8 6275.7 6275.8 6277.5 4369.5 4465.0 4471.5 4532.4 4538.0 6513.7 6552.2 6597.1 6598.8 6658.0 4504.2 4541.4 4544.7 4545.2 4549.2 4612.3 4614.8 4615.8 4623.1 4626.9 5282.8 5286.9 5288.6 5292.2 5292.8 6244.3 6357.7 6366.5 6390.7 6391.1 1638.9 1648.8 1656.6 1659.2 1662.6 1069.1 1112.7 1119.8 1128.9 1149.5 5974.5 6007.6 6027.6 6061.5 6122.4 6423.5 6427.5 6431.9 6457.7 6515.3 6032.7 6040.9 6045.7 6046.0 6047.6 3460.9 3492.7 3496.1 3498.1 3498.8 6542.6 6715.7 6717.0 6723.6 6724.6 6599.6 6605.0 6625.3 6628.7 6635.6 6703.1 6718.9 6719.5 6779.2 6786.4 6421.8 6473.3 6475.1 6493.6 6497.8 6300.9 6372.2 6396.8 6507.0 6510.2 6729.5 6807.5 6813.8 6816.4 6834.5 4452.0 4477.6 4479.3 4480.5 4487.9 6565.4 6576.0 6582.8 6585.2 6588.5 6280.9 6415.7 6416.1 6417.3 6429.2 6328.4 6360.1 6376.6 6382.8 6383.1 6295.8 6300.4 6305.3 6305.9 6306.8 6413.2 6448.4 6448.7 6449.8 6460.3 5891.9 5997.3 6098.1 6285.8 6287.0 08:19:45 INFO - PROCESS | 29283 | 08:19:45 INFO - PROCESS | 29283 | [#5] yui.html Cycles:180 Average:15064.72 Median:24853.50 stddev:17348.17 (69.8%) stddev-sans-first:17363.46 08:19:45 INFO - PROCESS | 29283 | Values: 733.0 773.5 823.0 844.2 856.7 13399.3 13503.7 13539.9 15697.1 15701.7 14358.6 14431.6 14433.2 14475.7 14489.1 671.8 682.4 819.6 821.7 832.4 837.0 838.1 840.6 841.7 841.8 880.5 884.1 884.3 884.8 885.3 707.6 858.9 871.0 871.8 873.8 631.7 632.3 632.4 633.1 634.1 13820.4 13859.1 13929.9 13935.3 13938.7 13218.0 13501.3 13550.3 13663.2 13681.1 12022.8 12169.3 12296.0 12372.1 12507.3 3851.6 3979.4 4012.8 4029.3 4041.8 51076.5 51291.7 51505.2 51812.5 51967.5 11095.7 11134.8 11235.8 11389.8 11454.8 20720.8 20735.0 20737.4 20764.5 20788.9 8170.5 8450.7 8534.1 8608.6 8710.8 4634.0 4674.5 4771.0 4777.5 4785.8 3390.7 3433.5 3434.3 3434.9 3450.9 568.8 603.1 603.8 606.3 658.3 540.4 586.8 629.9 631.3 701.6 8323.0 8669.2 8700.7 8826.0 8995.6 547.6 628.5 669.7 697.4 699.9 4136.4 4196.2 4244.4 4299.6 4430.2 55493.7 66005.7 66527.0 66679.7 71029.0 52748.7 53238.0 53493.7 53658.0 54184.7 49964.3 50059.7 50105.5 50376.0 51130.0 9494.6 9711.2 9727.8 9858.7 9865.7 36695.3 37615.4 38122.0 38435.6 38827.8 45073.0 48482.0 48585.5 49353.0 49476.5 11848.8 11950.3 12001.2 12211.3 12229.5 13449.3 13484.2 13541.5 13572.2 13594.0 12648.7 12783.3 12828.9 12910.3 12973.6 12265.9 12336.9 12679.4 13260.7 13382.3 11972.5 12000.6 12449.2 12540.9 13147.7 10120.7 10609.6 11003.5 11212.9 11662.4 10555.3 10606.2 10786.5 10788.1 10824.6 08:19:45 INFO - PROCESS | 29283 | -------- Summary: end -------- 08:19:45 INFO - PROCESS | 29283 | 08:19:46 INFO - TEST-INFO | 29283: exit 0 08:19:46 INFO - TEST-OK | dromaeo_css | took 1111249ms 08:19:46 INFO - TEST-START | kraken 08:19:46 INFO - operating with platform_type : linux_ 08:19:46 INFO - Initialising browser for kraken test... 08:19:46 INFO - TEST-INFO | started process 29468 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptGiyNq/profile http://localhost:56887/getInfo.html) 08:19:50 INFO - PROCESS | 29468 | __metrics Screen width/height:1600/1200 08:19:50 INFO - PROCESS | 29468 | colorDepth:24 08:19:50 INFO - PROCESS | 29468 | Browser inner width/height: 1024/697 08:19:50 INFO - PROCESS | 29468 | __metrics 08:19:51 ERROR - PROCESS | 29468 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:19:52 INFO - TEST-INFO | 29468: exit 0 08:19:52 INFO - Browser initialized. 08:19:52 INFO - Running cycle 1/1 for kraken test... 08:19:52 INFO - TEST-INFO | started process 29547 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptGiyNq/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:20:03 INFO - PROCESS | 29547 | RSS: Main: 153051136 08:20:03 INFO - PROCESS | 29547 | 08:20:06 INFO - PROCESS | 29547 | Cycle 1(1): loaded http://localhost:56887/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56887/tests/kraken/driver.html?testName=audio-beat-detection) 08:20:06 INFO - PROCESS | 29547 | RSS: Main: 197668864 08:20:06 INFO - PROCESS | 29547 | 08:20:09 INFO - PROCESS | 29547 | Cycle 1(1): loaded http://localhost:56887/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56887/tests/kraken/driver.html?testName=audio-dft) 08:20:10 INFO - PROCESS | 29547 | RSS: Main: 187564032 08:20:10 INFO - PROCESS | 29547 | 08:20:13 INFO - PROCESS | 29547 | Cycle 1(1): loaded http://localhost:56887/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56887/tests/kraken/driver.html?testName=audio-fft) 08:20:13 INFO - PROCESS | 29547 | RSS: Main: 169533440 08:20:13 INFO - PROCESS | 29547 | 08:20:15 INFO - PROCESS | 29547 | Cycle 1(1): loaded http://localhost:56887/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56887/tests/kraken/driver.html?testName=audio-oscillator) 08:20:16 INFO - PROCESS | 29547 | RSS: Main: 172871680 08:20:16 INFO - PROCESS | 29547 | 08:20:18 INFO - PROCESS | 29547 | Cycle 1(1): loaded http://localhost:56887/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56887/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:20:18 INFO - PROCESS | 29547 | RSS: Main: 174280704 08:20:18 INFO - PROCESS | 29547 | 08:20:21 INFO - PROCESS | 29547 | Cycle 1(1): loaded http://localhost:56887/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56887/tests/kraken/driver.html?testName=imaging-darkroom) 08:20:22 INFO - PROCESS | 29547 | RSS: Main: 174358528 08:20:22 INFO - PROCESS | 29547 | 08:20:25 INFO - PROCESS | 29547 | Cycle 1(1): loaded http://localhost:56887/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56887/tests/kraken/driver.html?testName=imaging-desaturate) 08:20:26 INFO - PROCESS | 29547 | RSS: Main: 176037888 08:20:26 INFO - PROCESS | 29547 | 08:20:29 INFO - PROCESS | 29547 | Cycle 1(1): loaded http://localhost:56887/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56887/tests/kraken/driver.html?testName=json-parse-financial) 08:20:29 INFO - PROCESS | 29547 | RSS: Main: 175915008 08:20:29 INFO - PROCESS | 29547 | 08:20:31 INFO - PROCESS | 29547 | Cycle 1(1): loaded http://localhost:56887/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56887/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:20:31 INFO - PROCESS | 29547 | RSS: Main: 185098240 08:20:31 INFO - PROCESS | 29547 | 08:20:33 INFO - PROCESS | 29547 | Cycle 1(1): loaded http://localhost:56887/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56887/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:20:34 INFO - PROCESS | 29547 | RSS: Main: 183611392 08:20:34 INFO - PROCESS | 29547 | 08:20:36 INFO - PROCESS | 29547 | Cycle 1(1): loaded http://localhost:56887/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56887/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:20:36 INFO - PROCESS | 29547 | RSS: Main: 192409600 08:20:36 INFO - PROCESS | 29547 | 08:20:39 INFO - PROCESS | 29547 | Cycle 1(1): loaded http://localhost:56887/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56887/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:20:39 INFO - PROCESS | 29547 | RSS: Main: 197365760 08:20:39 INFO - PROCESS | 29547 | 08:20:42 INFO - PROCESS | 29547 | Cycle 1(1): loaded http://localhost:56887/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56887/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:20:42 INFO - PROCESS | 29547 | RSS: Main: 194998272 08:20:42 INFO - PROCESS | 29547 | 08:20:44 INFO - PROCESS | 29547 | Cycle 1(1): loaded http://localhost:56887/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56887/tests/kraken/driver.html?testName=ai-astar) 08:20:44 INFO - PROCESS | 29547 | RSS: Main: 256204800 08:20:44 INFO - PROCESS | 29547 | 08:20:44 INFO - PROCESS | 29547 | __start_tp_report 08:20:44 INFO - PROCESS | 29547 | _x_x_mozilla_page_load 08:20:44 INFO - PROCESS | 29547 | _x_x_mozilla_page_load_details 08:20:44 INFO - PROCESS | 29547 | |i|pagename|runs| 08:20:44 INFO - PROCESS | 29547 | |0;ai-astar;110;110;104;109;110;109;98;108;109;109 08:20:44 INFO - PROCESS | 29547 | |1;audio-beat-detection;158;126;153;169;124;148;153;133;168;125 08:20:44 INFO - PROCESS | 29547 | |2;audio-dft;161;163;160;161;162;159;159;162;162;163 08:20:44 INFO - PROCESS | 29547 | |3;audio-fft;76;77;104;96;74;75;75;123;94;71 08:20:44 INFO - PROCESS | 29547 | |4;audio-oscillator;92;93;139;92;93;93;146;92;98;143 08:20:44 INFO - PROCESS | 29547 | |5;imaging-gaussian-blur;116;116;117;117;117;116;117;116;116;116 08:20:44 INFO - PROCESS | 29547 | |6;imaging-darkroom;145;145;146;145;145;145;146;146;145;145 08:20:44 INFO - PROCESS | 29547 | |7;imaging-desaturate;95;95;95;95;97;96;95;95;95;95 08:20:44 INFO - PROCESS | 29547 | |8;json-parse-financial;56;55;55;55;55;57;56;63;53;53 08:20:44 INFO - PROCESS | 29547 | |9;json-stringify-tinderbox;60;61;61;62;63;62;61;62;62;61 08:20:44 INFO - PROCESS | 29547 | |10;stanford-crypto-aes;77;78;79;79;80;79;88;86;80;79 08:20:44 INFO - PROCESS | 29547 | |11;stanford-crypto-ccm;114;113;126;108;120;112;116;124;109;129 08:20:44 INFO - PROCESS | 29547 | |12;stanford-crypto-pbkdf2;137;140;152;138;151;133;140;139;151;139 08:20:44 INFO - PROCESS | 29547 | |13;stanford-crypto-sha256-iterative;62;63;65;64;64;61;63;62;61;62 08:20:44 INFO - PROCESS | 29547 | __end_tp_report 08:20:44 INFO - PROCESS | 29547 | __start_cc_report 08:20:44 INFO - PROCESS | 29547 | _x_x_mozilla_cycle_collect,1004 08:20:44 INFO - PROCESS | 29547 | __end_cc_report 08:20:44 INFO - PROCESS | 29547 | __startTimestamp1458228044786__endTimestamp 08:20:44 INFO - PROCESS | 29547 | 08:20:44 INFO - PROCESS | 29547 | ------- Summary: start ------- 08:20:44 INFO - PROCESS | 29547 | Number of tests: 14 08:20:44 INFO - PROCESS | 29547 | 08:20:44 INFO - PROCESS | 29547 | [#0] ai-astar Cycles:10 Average:107.60 Median:109.50 stddev:3.81 (3.5%) stddev-sans-first:3.94 08:20:44 INFO - PROCESS | 29547 | Values: 110.0 110.0 104.0 109.0 110.0 109.0 98.0 108.0 109.0 109.0 08:20:44 INFO - PROCESS | 29547 | 08:20:44 INFO - PROCESS | 29547 | [#1] audio-beat-detection Cycles:10 Average:145.70 Median:153.00 stddev:17.49 (11.4%) stddev-sans-first:17.97 08:20:44 INFO - PROCESS | 29547 | Values: 158.0 126.0 153.0 169.0 124.0 148.0 153.0 133.0 168.0 125.0 08:20:44 INFO - PROCESS | 29547 | 08:20:44 INFO - PROCESS | 29547 | [#2] audio-dft Cycles:10 Average:161.20 Median:162.00 stddev:1.48 (0.9%) stddev-sans-first:1.56 08:20:44 INFO - PROCESS | 29547 | Values: 161.0 163.0 160.0 161.0 162.0 159.0 159.0 162.0 162.0 163.0 08:20:44 INFO - PROCESS | 29547 | 08:20:44 INFO - PROCESS | 29547 | [#3] audio-fft Cycles:10 Average:86.50 Median:75.50 stddev:17.15 (22.7%) stddev-sans-first:17.76 08:20:44 INFO - PROCESS | 29547 | Values: 76.0 77.0 104.0 96.0 74.0 75.0 75.0 123.0 94.0 71.0 08:20:44 INFO - PROCESS | 29547 | 08:20:44 INFO - PROCESS | 29547 | [#4] audio-oscillator Cycles:10 Average:108.10 Median:92.50 stddev:23.97 (25.9%) stddev-sans-first:24.71 08:20:44 INFO - PROCESS | 29547 | Values: 92.0 93.0 139.0 92.0 93.0 93.0 146.0 92.0 98.0 143.0 08:20:44 INFO - PROCESS | 29547 | 08:20:44 INFO - PROCESS | 29547 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 08:20:44 INFO - PROCESS | 29547 | Values: 116.0 116.0 117.0 117.0 117.0 116.0 117.0 116.0 116.0 116.0 08:20:44 INFO - PROCESS | 29547 | 08:20:44 INFO - PROCESS | 29547 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 08:20:44 INFO - PROCESS | 29547 | Values: 145.0 145.0 146.0 145.0 145.0 145.0 146.0 146.0 145.0 145.0 08:20:44 INFO - PROCESS | 29547 | 08:20:44 INFO - PROCESS | 29547 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 08:20:44 INFO - PROCESS | 29547 | Values: 95.0 95.0 95.0 95.0 97.0 96.0 95.0 95.0 95.0 95.0 08:20:44 INFO - PROCESS | 29547 | 08:20:44 INFO - PROCESS | 29547 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:55.50 stddev:2.82 (5.1%) stddev-sans-first:2.99 08:20:44 INFO - PROCESS | 29547 | Values: 56.0 55.0 55.0 55.0 55.0 57.0 56.0 63.0 53.0 53.0 08:20:44 INFO - PROCESS | 29547 | 08:20:44 INFO - PROCESS | 29547 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:62.00 stddev:0.85 (1.4%) stddev-sans-first:0.71 08:20:44 INFO - PROCESS | 29547 | Values: 60.0 61.0 61.0 62.0 63.0 62.0 61.0 62.0 62.0 61.0 08:20:44 INFO - PROCESS | 29547 | 08:20:44 INFO - PROCESS | 29547 | [#10] stanford-crypto-aes Cycles:10 Average:80.50 Median:79.50 stddev:3.57 (4.5%) stddev-sans-first:3.55 08:20:44 INFO - PROCESS | 29547 | Values: 77.0 78.0 79.0 79.0 80.0 79.0 88.0 86.0 80.0 79.0 08:20:44 INFO - PROCESS | 29547 | 08:20:44 INFO - PROCESS | 29547 | [#11] stanford-crypto-ccm Cycles:10 Average:117.10 Median:118.00 stddev:7.29 (6.2%) stddev-sans-first:7.65 08:20:44 INFO - PROCESS | 29547 | Values: 114.0 113.0 126.0 108.0 120.0 112.0 116.0 124.0 109.0 129.0 08:20:44 INFO - PROCESS | 29547 | 08:20:44 INFO - PROCESS | 29547 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.00 Median:140.00 stddev:6.75 (4.8%) stddev-sans-first:6.91 08:20:44 INFO - PROCESS | 29547 | Values: 137.0 140.0 152.0 138.0 151.0 133.0 140.0 139.0 151.0 139.0 08:20:44 INFO - PROCESS | 29547 | 08:20:44 INFO - PROCESS | 29547 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:63.00 stddev:1.34 (2.1%) stddev-sans-first:1.39 08:20:44 INFO - PROCESS | 29547 | Values: 62.0 63.0 65.0 64.0 64.0 61.0 63.0 62.0 61.0 62.0 08:20:44 INFO - PROCESS | 29547 | -------- Summary: end -------- 08:20:44 INFO - PROCESS | 29547 | 08:20:45 INFO - TEST-INFO | 29547: exit 0 08:20:45 INFO - TEST-OK | kraken | took 59216ms 08:20:45 INFO - SUITE-END | took 1170s 08:20:45 INFO - Completed test suite (00:19:30) 08:20:45 INFO - javascript benchmark 08:20:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3038.939221215576, 3067.6318841738994, 3110.1447102046936, 3116.283254851383, 3144.0253521408367, 5130.179171332587, 5194.376674799029, 5206.713630750307, 5249.055170069386, 5286.788528458862, 5163.690178589287, 5174.404943431507, 5182.11903976324, 5197.220416937452, 5304.867378315544, 4668.25307950728, 4681.812727490905, 4797.90404191916, 4851.22380419133, 4861.052094841507, 4615.446146462429, 4763.61891048717, 4807.807687692488, 4813.446453657822, 4908.190148625473, 4738.052389522092, 4744.312074749159, 4750.45369782476, 4768.570828625423, 4800.855974320741, 4740.265258884879, 4743.075100355432, 4757.5718185363485, 4769.928451073237, 4773.618110551148, 4628.421447319085, 4676.2050451423, 4690.038542098861, 4711.835085772016, 4714.222153344694, 4979.551840334351, 4994.35073440454, 4995.60035197187, 4998.475160108209, 5002.099622068026, 5451.672899625995, 5455.454454554552, 5456.317960254968, 5493.972530137324, 5580.051391263495, 5597.384287728347, 5602.0, 5602.60781745278, 5604.047311956977, 5630.324361076656, 5229.947700523022, 5265.0, 5268.473152684739, 5270.39390470097, 5271.42014378418, 5553.777848885999, 5662.094064949588, 5738.110592858114, 5763.567732420085, 5819.679917604488, 5526.005319042611, 5571.749271282802, 5571.832845014656, 5578.386377498472, 5599.720013999284, 5627.803026894039, 5727.7422515986045, 5728.856778580569, 5734.455226753452, 5735.11105778605, 5462.9726851365485, 5569.415211402745, 5625.606207565513, 5693.430656934356, 5704.743286552115, 5627.8874422512135, 5633.943660563424, 5638.182463542846, 5639.182318563785, 5642.463965923313, 4287.506936702319, 4310.482742070909, 4317.8272869084885, 4319.935200971988, 4350.456192975878, 3718.2563487302646, 3778.4899038629983, 3829.3107240696386, 3857.594952529944, 3871.96128038716, 5325.201219817059, 5327.360716713942, 5331.306930099062, 5344.038073146793, 5371.677699338053, 5572.414896435897, 5648.51987581052, 5649.519790817826, 5655.095184770417, 5655.293088363955, 5253.684778913277, 5254.868628284247, 5266.262723218752, 5307.681539107666, 5325.866853328698, 4651.720896746206, 4657.208274593259, 4660.790264438108, 4673.60274376675, 4708.764561771898, 5701.116326969326, 5792.623479473905, 5794.594378393556, 5796.942030579725, 5797.681127537941, 5549.805756798573, 5595.740958284354, 5606.159076138611, 5607.80372686954, 5645.604807663589, 5797.9420205797405, 5836.328822185503, 5838.4453476919625, 5848.093545500455, 5848.356680765198, 5434.049041417815, 5479.698616575967, 5508.283923089973, 5540.36285827135, 5556.444355564573, 5601.719914004202, 5603.0, 5605.299337582802, 5631.0427227372265, 5656.3495198051105, 5453.2365468833605, 5493.423190564933, 5496.6701997880255, 5499.340079190522, 5499.945000549943, 5393.83818485446, 5472.2338872557075, 5492.093804522209, 5522.641028333145, 5581.720913954205, 5409.377921539073, 5435.673859568438, 5438.15708565173, 5439.728013599225, 5464.535514481314, 5526.80656177048, 5528.44715528444, 5531.9723401382735, 5545.140503222007, 5604.607677462538, 5200.115980283285, 5267.209918512254, 5315.813946511854, 5383.380911195262, 5416.8104116355735], "unit": "score", "name": "dojo.html", "value": 5158.149217624563}, {"lowerIsBetter": false, "replicates": [552.6979515158973, 567.6225310168741, 570.3982298674896, 574.3366411794377, 591.8165368735691, 39492.40761388578, 39787.0, 39793.60206397935, 39806.40290395646, 39826.80086599563, 42257.36613950785, 42856.785716071456, 42886.57113428865, 42900.57099429005, 42933.35599966003, 8728.650853965833, 8908.420952638058, 8929.598168082419, 8932.33007524435, 8936.061713520085, 8744.0, 8810.383273170848, 8864.778380540474, 8866.822663546725, 8876.112388761137, 9132.08679132088, 9155.54222288883, 9197.448153110834, 9206.631734730636, 9208.539573021322, 8988.550572471382, 9032.0, 9041.276697864188, 9048.140426659456, 9055.0, 8923.955380223057, 9031.412958157698, 9041.412308199946, 9050.637974481013, 9071.546422678839, 42534.0, 43062.354064689054, 43065.13869722619, 43076.13847723059, 43136.352954705704, 3249.496328069153, 3457.94813077804, 3714.238581090897, 3874.8450061997487, 4388.166248412791, 30553.23616909573, 31165.37669246625, 31252.0, 31425.528617070762, 31594.0, 4279.1382070172085, 4309.6336811371075, 4326.394304797331, 4335.5456859124515, 4361.934570981438, 318960.0, 327307.0, 327375.0, 327448.0, 328307.0, 66572.66713666498, 67554.66222668953, 68140.6592967042, 68271.0, 68298.0, 71766.0, 72628.63685681538, 72633.27366726265, 72634.0, 72900.0, 15946.362145514282, 16238.431654892021, 16257.268422920997, 16280.26738796757, 16287.0, 12085.093617978686, 12088.03295736339, 12145.271283722828, 12146.210496317712, 12148.21036632616, 22135.557288854456, 22308.442288942908, 22352.0, 22515.099396023976, 22537.43656408603, 8639.611217495229, 8933.910660893307, 8997.325200609981, 9013.414128081786, 9138.268938484905, 1030.4229631406436, 1106.4578356605205, 1115.9721006974728, 1125.4372813593204, 1235.1415766042694, 31835.68164318327, 33067.338653227285, 33407.3318533628, 33425.164370890925, 33732.156696082304, 1108.9279196852178, 1132.5186795611833, 1164.4527072276016, 1196.2583198416862, 1243.2167734327315, 16908.32366705318, 17259.13704314779, 17323.740143897852, 17327.22027508765, 17492.562685932953, 790196.0, 797869.0, 800127.0, 803547.0, 805236.0, 58979.410205897395, 60283.69858150769, 60322.39677603168, 60422.09366859501, 60488.395116049156, 1240.3178251961385, 1330.1885849631717, 1395.8813500852339, 1416.773316269392, 1450.0574626492864, 30740.84814062994, 32374.83812580922, 32482.51276230811, 32704.67295327016, 32842.67157328396, 45021.77489112534, 45612.315815263464, 46192.30711539262, 46307.3053904185, 46374.53625463837, 283564.0, 284543.0, 285022.0, 285833.0, 286162.0, 31653.050408487783, 36235.27529449343, 36364.27271454609, 36504.0, 36790.63209367872, 43361.566384335754, 43485.130297394506, 43558.128837423705, 43793.343099854166, 43805.56194438015, 36027.459588105674, 36538.0, 36730.4490432649, 36759.448608271436, 37125.443118352705, 35963.28073438464, 36618.63381366152, 36700.26599468049, 37052.62947370492, 37327.81336093302, 36461.635383646884, 38596.42105368478, 40835.0, 41057.79471102745, 41164.38253426261, 32537.511937321433, 34934.82532587321, 35224.64775352316, 35227.0, 35258.294834102664, 27588.586171207047, 27629.30926726848, 27963.580546291414, 28004.57993130064, 28259.576106358832], "unit": "score", "name": "ext.html", "value": 20354.01340753639}, {"lowerIsBetter": false, "replicates": [359.5361983041876, 364.45695913089503, 366.53816191598594, 366.80192695944186, 381.27177091754754, 17204.65590688187, 17290.827091729094, 18070.4578862634, 18079.548011299725, 18098.99999999998, 16532.66934661306, 17625.47123586291, 17645.55886102848, 17661.91169044156, 17668.116594170304, 4654.301854721785, 4880.023995200974, 4881.1213981483315, 4885.120678277908, 4889.755512224392, 3876.030992251937, 4804.591609713161, 5328.5470734987575, 5516.724163791814, 5551.084071128259, 5517.475839795213, 5523.7790488380415, 5528.723563821813, 5532.6680399175975, 5538.418466061066, 5354.625176237665, 5473.507384335389, 5511.53151982082, 5541.445855414467, 5555.666660000393, 5318.547923426513, 5318.946810531884, 5342.759575819097, 5349.625526213128, 5353.491418315292, 13075.084744067919, 13447.125936814173, 13495.460181592725, 13496.325183740773, 13496.595102146952, 2173.5435558532727, 2179.9128034878586, 2283.977160228393, 2302.435903203709, 2413.0589070262613, 9539.14147726708, 9572.904270957271, 9804.705858824176, 9944.35361701487, 9954.751131221705, 1938.8255057044935, 1949.6198241342943, 2010.5677279384856, 2016.4152395805345, 2029.4723371923405, 64487.0, 71303.99999999948, 71801.0, 71868.28131718669, 72341.0, 10730.087942524973, 10757.354558726502, 10989.99999999984, 10994.230403871652, 11169.0, 14127.434902603985, 14152.22162781057, 14282.21447820359, 14301.713965720628, 14308.785368219485, 7693.0, 8007.0, 8013.7996550085545, 8100.756977290691, 8161.061477930114, 7797.610119494003, 7805.258500442449, 7839.059312882377, 7938.206179382016, 7987.9201207988335, 4637.003044345414, 4642.141203877293, 4649.721016739007, 4653.395058642355, 4722.527747225318, 1760.9295628174987, 1820.6904826179582, 1844.483544607485, 1872.2230274435956, 1882.341180586811, 989.2778271861581, 1014.6651604970342, 1078.2883297023927, 1086.473060565625, 1127.447550700151, 17023.0, 17199.1400429978, 17368.39210627622, 17571.56071098233, 17733.29066837312, 1019.3700253346349, 1023.7901230247782, 1064.7125276175389, 1065.6909496246158, 1078.2182917384832, 8059.791031345345, 10297.794044119075, 10388.272820902615, 10576.52405641748, 10646.20153488476, 484137.0, 489773.0, 498344.0, 509737.0, 510851.0, 79752.60123699345, 80360.59819700864, 80835.19164808394, 81206.0, 81786.0, 1021.6577446555339, 1030.8093002794508, 1041.1306559023149, 1045.257866914484, 1046.2048842879467, 15996.280167392262, 16064.67870642604, 16106.597335066717, 16224.35102595883, 16402.687784976933, 34680.13299667528, 34933.301333973686, 35420.645793541735, 35485.467717984764, 35878.0, 47445.17888993787, 50963.49036509736, 51155.744221278655, 51510.48489515207, 52114.218286726486, 8050.993625796776, 8119.147489513753, 8145.42981991255, 8390.958045209734, 8418.452800567944, 9441.055894410503, 12572.497100115894, 12947.61157165249, 12972.545960891324, 12996.220226786423, 11255.493502792559, 11500.654980350602, 11601.825972610586, 11690.532378704756, 11818.290902545874, 11060.56212692377, 11064.22550421495, 11267.661970140909, 11338.206325557132, 11425.657230283105, 11506.712332191762, 11744.471498782405, 11756.647300580997, 11757.412129393668, 11926.701832454259, 8084.636191371284, 8123.7969050771835, 8191.549464779494, 8254.968128983877, 8356.373272004746, 11281.153913456359, 11519.654410367702, 11552.364619945984, 11652.242604230698, 11702.824457632973], "unit": "score", "name": "jquery.html", "value": 8644.570269674736}, {"lowerIsBetter": false, "replicates": [1240.1938739819122, 1463.7584798508246, 1469.3902030657277, 1663.376233912283, 1839.8252166044222, 7876.1730018348035, 8057.758267251985, 8071.596420178997, 8071.6367763450635, 8121.756347309575, 7931.127575966639, 8067.47561408508, 8073.959630201855, 8094.352451803857, 8108.472949258309, 2037.5924815036979, 2294.701688780456, 2303.378087916266, 2334.708161479815, 2346.3195673254736, 2335.871527066011, 2340.4733934864603, 2343.4610039690883, 2344.308429013445, 2344.9296521104393, 2222.4777177363308, 2274.533720587284, 2279.726432828063, 2279.817614590837, 2280.9657855132186, 2295.288460577218, 2317.142657216824, 2379.7382287948312, 2385.940351491209, 2391.2228525729206, 2330.1378489958656, 2337.135259953828, 2337.6026075567192, 2348.2602980061224, 2349.1543044504137, 8246.793830154234, 8322.62548185333, 8324.542150181738, 8326.375521835887, 8326.583670816435, 5021.748912554394, 5137.845864624067, 5140.897182056338, 5142.614303927183, 5143.691378517264, 3239.9838000809846, 3327.2014716467875, 3400.60892997306, 3432.1248081739245, 3438.862445502177, 1094.7263184203948, 1132.8697199822043, 1138.408027825526, 1147.4033502578613, 1153.4924633161465, 11379.829302560469, 11440.313581185155, 11514.769704605944, 11515.827262591069, 11517.654470365902, 4496.977515112403, 4584.679072464962, 4600.056988317387, 4600.35595016698, 4627.652926030494, 9771.51142442875, 9839.311248212556, 9840.0, 9840.65557705477, 9846.803063938682, 4546.0680560485025, 5107.846764597068, 5117.513836185556, 5119.924815788726, 5133.23001549763, 4564.6348292136545, 4615.953840461552, 4670.673052886265, 4671.85984420468, 4685.0395668887795, 3933.272344616198, 3990.20195960809, 3993.72043956926, 4026.074002979273, 4040.010197501631, 1232.648695121886, 1236.110000799441, 1241.5530409052733, 1242.5278394210143, 1247.2765795838393, 1380.4064252371377, 1382.8340599128169, 1403.2632867744517, 1415.3984556563419, 1417.149710173908, 7919.841603167904, 8096.190380961857, 8109.878351824727, 8116.066652334939, 8120.0, 488.35780948053196, 495.5391485918059, 497.69391824028685, 501.52856315063724, 501.59621504688346, 6078.331383547807, 6086.482648974798, 6098.634081955097, 6175.2898416681755, 6179.5056395488255, 9315.208207302456, 9505.809883802423, 9697.757556061155, 9720.61117555304, 9809.803803924024, 9431.764205894908, 9679.70960871175, 9712.17446517054, 9728.075832795874, 9764.853527197098, 7763.573003484749, 7889.289963903277, 7896.921030789734, 7958.522488650699, 7961.40289478303, 7815.218478152139, 7845.9215407845195, 7947.284744373034, 7955.323797477279, 7960.6417711201975, 8856.424332418372, 8978.191962723386, 9110.90889091127, 9158.358914875895, 9264.44413335202, 9242.214411775074, 9242.445453272825, 9331.486768227813, 9333.439993600407, 9361.625534978524, 6498.317676643885, 6676.766313179015, 7055.6472176392, 7335.8532829344185, 7444.962775186089, 7860.410469214946, 7867.606619669108, 7869.3311068559815, 7909.1695371985115, 7917.683292668229, 6860.936554834008, 6989.615571143432, 6990.776614092615, 7065.22282548909, 7186.820329491805, 7164.9641751790905, 7187.173475050227, 7224.169220539495, 7228.96385518069, 7291.562506249642, 7376.4836461447185, 7642.121156067124, 7644.961775191088, 7650.885236721565, 7653.311201991847, 6930.064441300561, 6940.063091482585, 6954.200266969363, 6960.443164546723, 6963.1296087989, 6992.0, 7061.1173603299585, 7079.327463890922, 7100.4319654428555, 7102.325279098477], "unit": "score", "name": "mootools.html", "value": 4656.113772589123}, {"lowerIsBetter": false, "replicates": [342.0644537190783, 342.8731369393325, 344.0469898381482, 345.31110434682813, 354.22424889492027, 5888.7644494220285, 5931.85170370741, 5956.642601443911, 5958.404159584039, 5963.522918166547, 5838.532917366611, 5840.445157710011, 5843.094320380337, 5847.327557330908, 5860.76556937723, 4380.145871555048, 4404.603585677289, 4489.1919454498175, 4549.613282870943, 4557.270836666125, 4522.796474158671, 4526.6831321807485, 4533.093381323732, 4545.863624091266, 4548.022175232324, 4492.460904691426, 4493.9775301123445, 4501.932471012921, 4504.301833215841, 4506.729596224237, 4372.27857403528, 4447.3996010538485, 4494.258447356182, 4509.323601459807, 4511.571400716926, 3982.183652351261, 3988.4017397390335, 3992.0, 3992.301347264217, 3996.3406038003695, 5678.801241956512, 5739.512141467981, 5742.2247996520355, 5745.511631511326, 5746.281714785652, 5337.866553336197, 5342.519173274385, 5343.545798607084, 5343.62594618373, 5364.22218778275, 6268.561200715906, 6272.780452684134, 6275.7489700411925, 6275.811725648238, 6277.4664153547, 4369.47566292047, 4465.0, 4471.485779135409, 4532.4334458192725, 4537.954620453819, 6513.739450421977, 6552.213734351861, 6597.076409302702, 6598.802035938881, 6658.0, 4504.166729155117, 4541.364209010741, 4544.727316361029, 4545.204589196877, 4549.181147393435, 4612.262038073892, 4614.8384806532285, 4615.815367385267, 4623.075384923029, 4626.907461850744, 5282.841514754564, 5286.920696189561, 5288.550473209743, 5292.179712144623, 5292.788288468418, 6244.313125556185, 6357.745690172342, 6366.4588509977175, 6390.680465976682, 6391.1371964785085, 1638.901665900026, 1648.7609296651917, 1656.577572718973, 1659.1621231278127, 1662.6009757658076, 1069.1126365116934, 1112.7440688641657, 1119.809632362484, 1128.9435528223555, 1149.494222542079, 5974.492168165668, 6007.609505382136, 6027.57806953509, 6061.515078793686, 6122.357152498924, 6423.454006409507, 6427.517936154807, 6431.935680643227, 6457.7094030767785, 6515.348465153542, 6032.698365081728, 6040.939590604038, 6045.72794224261, 6045.969770151121, 6047.576669633171, 3460.9307813843584, 3492.7031202348085, 3496.1084923344383, 3498.1429549760473, 3498.772579782306, 6542.6401547914365, 6715.664216789141, 6717.026031225445, 6723.596584204964, 6724.562903411263, 6599.60402375859, 6605.009248612747, 6625.337466253336, 6628.734850605922, 6635.568688035262, 6703.061571380011, 6718.899216511756, 6719.462443004548, 6779.186497620317, 6786.389224969677, 6421.775237866652, 6473.320301368289, 6475.061116138039, 6493.577917435352, 6497.837554061186, 6300.905486417799, 6372.203474565679, 6396.840078998062, 6507.0, 6510.18622672166, 6729.528932974645, 6807.523473356818, 6813.7615183470325, 6816.386525212754, 6834.487413444111, 4451.977740111279, 4477.619402350837, 4479.3057076153245, 4480.484744254452, 4487.910241795081, 6565.441937435371, 6576.0464732612545, 6582.76960306387, 6585.242697089896, 6588.505862060269, 6280.874382512416, 6415.743370265137, 6416.13382193398, 6417.326180750954, 6429.196350456193, 6328.398802113792, 6360.077788720702, 6376.585521941059, 6382.840428989312, 6383.106365108795, 6295.811125666238, 6300.369963003663, 6305.274893387319, 6305.873882522232, 6306.810795676137, 6413.230412350548, 6448.419642232222, 6448.742050317935, 6449.838754030999, 6460.289368169404, 5891.882162356643, 5997.280326360865, 6098.146259523582, 6285.779997700059, 6286.968565157328], "unit": "score", "name": "prototype.html", "value": 4783.959043415503}, {"lowerIsBetter": false, "replicates": [732.9560226386417, 773.5436092705303, 822.9958850205749, 844.1853611265132, 856.6530555125177, 13399.263040532778, 13503.66240843978, 13539.932300338496, 15697.058176509418, 15701.685966280667, 14358.569242922704, 14431.639209019753, 14433.206173660445, 14475.710485790278, 14489.130652160879, 671.8253254153931, 682.379035078079, 819.5615345789988, 821.6959724901794, 832.4048305461594, 836.9832603347929, 838.0613712641849, 840.5587066789923, 841.7222316635496, 841.7769291137823, 880.5113162194979, 884.054062153496, 884.2969838977996, 884.752269364579, 885.3404213860683, 707.6072779607316, 858.858288382413, 870.9912900870974, 871.8430682477151, 873.7946582553095, 631.7062565906875, 632.3139393757779, 632.4244937107256, 633.1262857256955, 634.0647544871324, 13820.37808298629, 13859.099158554662, 13929.86070139306, 13935.303234838319, 13938.651533711636, 13218.008649351337, 13501.277511318318, 13550.254735989516, 13663.248521331323, 13681.110727802661, 12022.819657705142, 12169.330686812222, 12296.0, 12372.13395062346, 12507.312097834707, 3851.5570709368503, 3979.3633018717155, 4012.799360031987, 4029.254587901218, 4041.7777022263763, 51076.48923510755, 51291.743541282056, 51505.22742158871, 51812.48187518152, 51967.48032519702, 11095.722606934729, 11134.832977505344, 11235.83146252807, 11389.829152562717, 11454.770904581861, 20720.792792071887, 20735.0, 20737.377878663665, 20764.480887977923, 20788.896055519624, 8170.509769413854, 8450.661973521113, 8534.146585341416, 8608.612612432331, 8710.82578348442, 4634.0, 4674.485806561275, 4770.952290477051, 4777.546133117348, 4785.808567657325, 3390.69483746464, 3433.4678124890684, 3434.278801451723, 3434.862605495802, 3450.879219227315, 568.778176511161, 603.0532064658444, 603.7584966013629, 606.3481757111123, 658.2989116590816, 540.394757871179, 586.7502220270881, 629.8897692903815, 631.324482803396, 701.6456689371937, 8322.958385208036, 8669.21977022071, 8700.738977830675, 8825.955870220736, 8995.595198216097, 547.6495043172373, 628.531743850834, 669.7053296549502, 697.3723648716197, 699.8845190543503, 4136.358864376027, 4196.181744559843, 4244.3633454982, 4299.634531064895, 4430.224710675619, 55493.72253138709, 66005.66997164984, 66527.0, 66679.66660166669, 71029.0, 52748.736256319244, 53238.0, 53493.732531337875, 53658.0, 54184.72907635516, 49964.250536241256, 50059.74970125199, 50105.49894501081, 50376.0, 51130.0, 9494.620215191315, 9711.223102151953, 9727.805443891224, 9858.704238872846, 9865.654702085392, 36695.26609467742, 37615.43576846295, 38122.0, 38435.6156438432, 38827.805860971646, 45073.0, 48482.0, 48585.5141448581, 49353.0, 49476.50523494719, 11848.76302473963, 11950.282983021047, 12001.1599188056, 12211.26732396059, 12229.510819567118, 13449.260290684106, 13484.190948543119, 13541.526046588322, 13572.1856688599, 13594.048416610742, 12648.74702505963, 12783.296918669563, 12828.871711282767, 12910.289934053717, 12973.610791676265, 12265.877341226831, 12336.876631233932, 12679.366031698562, 13260.668483287995, 13382.330883455983, 11972.461239244081, 12000.57997970067, 12449.190802597803, 12540.87459125397, 13147.671308217372, 10120.746981325527, 10609.575616975235, 11003.504842281956, 11212.887871121184, 11662.416879156179, 10555.313904596484, 10606.151507879506, 10786.460676966277, 10788.083012943674, 10824.621138260123], "unit": "score", "name": "yui.html", "value": 6781.705774105626}], "name": "dromaeo_css", "value": 7180.913933036397}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 110.0, 104.0, 109.0, 110.0, 109.0, 98.0, 108.0, 109.0, 109.0], "unit": "score", "name": "ai-astar", "value": 107.6}, {"lowerIsBetter": true, "replicates": [158.0, 126.0, 153.0, 169.0, 124.0, 148.0, 153.0, 133.0, 168.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 145.7}, {"lowerIsBetter": true, "replicates": [161.0, 163.0, 160.0, 161.0, 162.0, 159.0, 159.0, 162.0, 162.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [76.0, 77.0, 104.0, 96.0, 74.0, 75.0, 75.0, 123.0, 94.0, 71.0], "unit": "score", "name": "audio-fft", "value": 86.5}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 139.0, 92.0, 93.0, 93.0, 146.0, 92.0, 98.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 108.1}, {"lowerIsBetter": true, "replicates": [116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.4}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 146.0, 146.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.3}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 97.0, 96.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 55.0, 55.0, 55.0, 57.0, 56.0, 63.0, 53.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.8}, {"lowerIsBetter": true, "replicates": [60.0, 61.0, 61.0, 62.0, 63.0, 62.0, 61.0, 62.0, 62.0, 61.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 61.5}, {"lowerIsBetter": true, "replicates": [77.0, 78.0, 79.0, 79.0, 80.0, 79.0, 88.0, 86.0, 80.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.5}, {"lowerIsBetter": true, "replicates": [114.0, 113.0, 126.0, 108.0, 120.0, 112.0, 116.0, 124.0, 109.0, 129.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.1}, {"lowerIsBetter": true, "replicates": [137.0, 140.0, 152.0, 138.0, 151.0, 133.0, 140.0, 139.0, 151.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.0}, {"lowerIsBetter": true, "replicates": [62.0, 63.0, 65.0, 64.0, 64.0, 61.0, 63.0, 62.0, 61.0, 62.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 62.7}], "name": "kraken", "value": 1485.6999999999998}]} 08:20:46 INFO - Return code: 0 08:20:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 08:20:46 ERROR - # TBPL SUCCESS # 08:20:46 INFO - Running post-action listener: _resource_record_post_action 08:20:46 INFO - Running post-run listener: _resource_record_post_run 08:20:47 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 527163392; Read time: 84; Write time: 524936 08:20:47 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 242483200; Read time: 0; Write time: 289836 08:20:47 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 284680192; Read time: 84; Write time: 235100 08:20:47 INFO - Running post-run listener: _upload_blobber_files 08:20:47 INFO - Blob upload gear active. 08:20:47 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 08:20:47 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:20:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 08:20:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 08:20:47 INFO - (blobuploader) - INFO - Open directory for files ... 08:20:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 08:20:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:20:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:20:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:20:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:20:48 INFO - (blobuploader) - INFO - Done attempting. 08:20:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:20:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:20:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:20:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:20:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:20:49 INFO - (blobuploader) - INFO - Done attempting. 08:20:49 INFO - (blobuploader) - INFO - Iteration through files over. 08:20:49 INFO - Return code: 0 08:20:49 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 08:20:49 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 08:20:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/792be97e1fd0a3329eccc87e70cba7a0b4c36e53b621f6172fc3f45fa97cece6e5cb67f168237da21eb9f47bfc7166c8dfd0539ca2f75341cfb981940281790a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3d960f074b5561599138910891c0fdaa6942ddc3fe969f8034f374ce2f81e93ab0aff1af737575c98bdc0f32757798549cdf3b0c5812a70a1b85722ce02cad86"} 08:20:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 08:20:49 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 08:20:49 INFO - Contents: 08:20:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/792be97e1fd0a3329eccc87e70cba7a0b4c36e53b621f6172fc3f45fa97cece6e5cb67f168237da21eb9f47bfc7166c8dfd0539ca2f75341cfb981940281790a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3d960f074b5561599138910891c0fdaa6942ddc3fe969f8034f374ce2f81e93ab0aff1af737575c98bdc0f32757798549cdf3b0c5812a70a1b85722ce02cad86"} 08:20:49 INFO - Running post-run listener: copy_logs_to_upload_dir 08:20:49 INFO - Copying logs to upload dir... 08:20:49 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 08:20:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.866115 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-03-17 08:20:48.900431) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-17 08:20:48.903984) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1458225981.900297-611633519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/792be97e1fd0a3329eccc87e70cba7a0b4c36e53b621f6172fc3f45fa97cece6e5cb67f168237da21eb9f47bfc7166c8dfd0539ca2f75341cfb981940281790a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3d960f074b5561599138910891c0fdaa6942ddc3fe969f8034f374ce2f81e93ab0aff1af737575c98bdc0f32757798549cdf3b0c5812a70a1b85722ce02cad86"} build_url:https://queue.taskcluster.net/v1/task/bughPZShQsyLYBaiDoWKqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011484 build_url: 'https://queue.taskcluster.net/v1/task/bughPZShQsyLYBaiDoWKqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/792be97e1fd0a3329eccc87e70cba7a0b4c36e53b621f6172fc3f45fa97cece6e5cb67f168237da21eb9f47bfc7166c8dfd0539ca2f75341cfb981940281790a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3d960f074b5561599138910891c0fdaa6942ddc3fe969f8034f374ce2f81e93ab0aff1af737575c98bdc0f32757798549cdf3b0c5812a70a1b85722ce02cad86"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-17 08:20:48.928486) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 08:20:48.928788) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1458225981.900297-611633519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004468 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 08:20:49.012170) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-17 08:20:49.012473) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-17 08:20:49.012766) ========= ========= Total master_lag: 0.26 =========