builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-027 starttime: 1460611577.32 results: success (0) buildid: 20160413193308 builduid: 223c48c871294287a1c513c53c83f8d2 revision: 8630367f5e3f750e23cd04f309a1b279ff07e4a2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-13 22:26:17.325348) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-13 22:26:17.326200) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-13 22:26:17.326548) ========= 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=1f5564757af27664ca02d71f000001b0-1460610782.968931-43161327 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006353 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-13 22:26:17.351366) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-13 22:26:17.351685) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-13 22:26:17.369811) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 22:26:17.370128) ========= 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=1f5564757af27664ca02d71f000001b0-1460610782.968931-43161327 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004655 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 22:26:17.419243) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-13 22:26:17.419593) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-13 22:26:17.420032) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 22:26:17.420362) ========= 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=1f5564757af27664ca02d71f000001b0-1460610782.968931-43161327 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-13 22:26:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 89.0M=0s 2016-04-13 22:26:17 (89.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123755 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 22:26:17.557333) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 22:26:17.557714) ========= 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=1f5564757af27664ca02d71f000001b0-1460610782.968931-43161327 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022698 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 22:26:17.608496) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 22:26:17.608913) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8630367f5e3f750e23cd04f309a1b279ff07e4a2 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 8630367f5e3f750e23cd04f309a1b279ff07e4a2 --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=1f5564757af27664ca02d71f000001b0-1460610782.968931-43161327 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-13 22:26:17,771 truncating revision to first 12 chars 2016-04-13 22:26:17,771 Setting DEBUG logging. 2016-04-13 22:26:17,771 attempt 1/10 2016-04-13 22:26:17,771 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8630367f5e3f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-13 22:26:18,396 unpacking tar archive at: mozilla-central-8630367f5e3f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.900849 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 22:26:18.523601) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-13 22:26:18.524065) ========= echo 8630367f5e3f750e23cd04f309a1b279ff07e4a2 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'8630367f5e3f750e23cd04f309a1b279ff07e4a2'] 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=1f5564757af27664ca02d71f000001b0-1460610782.968931-43161327 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 8630367f5e3f750e23cd04f309a1b279ff07e4a2 program finished with exit code 0 elapsedTime=0.004439 script_repo_revision: '8630367f5e3f750e23cd04f309a1b279ff07e4a2' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-13 22:26:18.575608) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-13 22:26:18.575983) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-13 22:26:18.586322) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-04-13 22:26:18.586644) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=1f5564757af27664ca02d71f000001b0-1460610782.968931-43161327 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:26:18 INFO - MultiFileLogger online at 20160413 22:26:18 in /builds/slave/test-pgo 22:26:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 22:26:18 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:26:18 INFO - {'append_to_log': False, 22:26:18 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:26:18 INFO - 'blob_upload_branch': 'Firefox', 22:26:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:26:18 INFO - 'branch': 'Firefox', 22:26:18 INFO - 'buildbot_json_path': 'buildprops.json', 22:26:18 INFO - 'config_files': ('talos/linux_config.py',), 22:26:18 INFO - 'default_actions': ('clobber', 22:26:18 INFO - 'read-buildbot-config', 22:26:18 INFO - 'download-and-extract', 22:26:18 INFO - 'populate-webroot', 22:26:18 INFO - 'create-virtualenv', 22:26:18 INFO - 'install', 22:26:18 INFO - 'run-tests'), 22:26:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:26:18 INFO - 'download_minidump_stackwalk': True, 22:26:18 INFO - 'download_symbols': 'ondemand', 22:26:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:26:18 INFO - 'tooltool.py': '/tools/tooltool.py', 22:26:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:26:18 INFO - '/tools/misc-python/virtualenv.py')}, 22:26:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:26:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:26:18 INFO - 'installer_path': 'installer.exe', 22:26:18 INFO - 'log_level': 'info', 22:26:18 INFO - 'log_name': 'talos', 22:26:18 INFO - 'log_to_console': True, 22:26:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:26:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:26:18 INFO - 'opt_config_files': (), 22:26:18 INFO - 'pip_index': False, 22:26:18 INFO - 'sps_profile': False, 22:26:18 INFO - 'sps_profile_interval': 0, 22:26:18 INFO - 'suite': 'dromaeojs', 22:26:18 INFO - 'system_bits': '32', 22:26:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:26:18 INFO - 'title': 'talos-linux64-ix-027', 22:26:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:26:18 INFO - 'use_talos_json': True, 22:26:18 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:26:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:26:18 INFO - 'work_dir': 'build'} 22:26:18 INFO - ##### 22:26:18 INFO - ##### Running clobber step. 22:26:18 INFO - ##### 22:26:18 INFO - Running pre-action listener: _resource_record_pre_action 22:26:18 INFO - Running main action method: clobber 22:26:18 INFO - rmtree: /builds/slave/test-pgo/build 22:26:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:26:19 INFO - Running post-action listener: _resource_record_post_action 22:26:19 INFO - ##### 22:26:19 INFO - ##### Running read-buildbot-config step. 22:26:19 INFO - ##### 22:26:19 INFO - Running pre-action listener: _resource_record_pre_action 22:26:19 INFO - Running main action method: read_buildbot_config 22:26:19 INFO - Using buildbot properties: 22:26:19 INFO - { 22:26:19 INFO - "project": "", 22:26:19 INFO - "product": "firefox", 22:26:19 INFO - "script_repo_revision": "production", 22:26:19 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 22:26:19 INFO - "repository": "", 22:26:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 22:26:19 INFO - "buildid": "20160413193308", 22:26:19 INFO - "pgo_build": "True", 22:26:19 INFO - "basedir": "/builds/slave/test-pgo", 22:26:19 INFO - "buildnumber": 745, 22:26:19 INFO - "slavename": "talos-linux64-ix-027", 22:26:19 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:26:19 INFO - "platform": "ubuntu64_hw", 22:26:19 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 22:26:19 INFO - "branch": "mozilla-central", 22:26:19 INFO - "repo_path": "mozilla-central", 22:26:19 INFO - "revision": "8630367f5e3f750e23cd04f309a1b279ff07e4a2", 22:26:19 INFO - "stage_platform": "linux64-pgo", 22:26:19 INFO - "builduid": "223c48c871294287a1c513c53c83f8d2", 22:26:19 INFO - "slavebuilddir": "test" 22:26:19 INFO - } 22:26:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/SjZF20saQ5-MMJUDtEN1cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 22:26:19 INFO - Running post-action listener: _resource_record_post_action 22:26:19 INFO - ##### 22:26:19 INFO - ##### Running download-and-extract step. 22:26:19 INFO - ##### 22:26:19 INFO - Running pre-action listener: _resource_record_pre_action 22:26:19 INFO - Running main action method: download_and_extract 22:26:19 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:26: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')]} 22:26:19 INFO - https://queue.taskcluster.net/v1/task/SjZF20saQ5-MMJUDtEN1cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:26:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SjZF20saQ5-MMJUDtEN1cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:26:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SjZF20saQ5-MMJUDtEN1cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:26:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SjZF20saQ5-MMJUDtEN1cg/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 22:26:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SjZF20saQ5-MMJUDtEN1cg/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 22:26:23 INFO - Downloaded 1361 bytes. 22:26:23 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:26:23 INFO - Using the following test package requirements: 22:26:23 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:26:23 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:26:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:26:23 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:26:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:26:23 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:26:23 INFO - u'jsshell-linux-x86_64.zip'], 22:26:23 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:26:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:26:23 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:26:23 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:26:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:26:23 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:26:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:26:23 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:26:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:26:23 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:26:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:26:23 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:26:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:26:23 INFO - https://queue.taskcluster.net/v1/task/SjZF20saQ5-MMJUDtEN1cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:26:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SjZF20saQ5-MMJUDtEN1cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:26:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SjZF20saQ5-MMJUDtEN1cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:26:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SjZF20saQ5-MMJUDtEN1cg/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 22:26:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SjZF20saQ5-MMJUDtEN1cg/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 22:26:31 INFO - Downloaded 23774614 bytes. 22:26:31 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'] 22:26:31 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 22:26:32 INFO - Return code: 0 22:26:32 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 22:26:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:26:32 INFO - https://queue.taskcluster.net/v1/task/SjZF20saQ5-MMJUDtEN1cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:26:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SjZF20saQ5-MMJUDtEN1cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:26:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SjZF20saQ5-MMJUDtEN1cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:26:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SjZF20saQ5-MMJUDtEN1cg/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 22:26:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SjZF20saQ5-MMJUDtEN1cg/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 22:26:37 INFO - Downloaded 23774614 bytes. 22:26:37 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'] 22:26:37 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 22:26:38 INFO - Return code: 0 22:26: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')]} 22:26:38 INFO - https://queue.taskcluster.net/v1/task/SjZF20saQ5-MMJUDtEN1cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:26:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SjZF20saQ5-MMJUDtEN1cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:26:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SjZF20saQ5-MMJUDtEN1cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:26:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SjZF20saQ5-MMJUDtEN1cg/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 22:26:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SjZF20saQ5-MMJUDtEN1cg/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 22:26:39 INFO - Downloaded 10841076 bytes. 22:26:39 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'] 22:26:39 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 22:26:39 INFO - Return code: 0 22:26:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:26:39 INFO - https://queue.taskcluster.net/v1/task/SjZF20saQ5-MMJUDtEN1cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:26:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SjZF20saQ5-MMJUDtEN1cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:26:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SjZF20saQ5-MMJUDtEN1cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:26:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SjZF20saQ5-MMJUDtEN1cg/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 22:26:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SjZF20saQ5-MMJUDtEN1cg/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 22:26:41 INFO - Downloaded 57874213 bytes. 22:26:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SjZF20saQ5-MMJUDtEN1cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:26:41 INFO - mkdir: /builds/slave/test-pgo/properties 22:26:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:26:41 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:26:41 INFO - Contents: 22:26:41 INFO - build_url:https://queue.taskcluster.net/v1/task/SjZF20saQ5-MMJUDtEN1cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:26:41 INFO - Running post-action listener: _resource_record_post_action 22:26:41 INFO - Running post-action listener: set_extra_try_arguments 22:26:41 INFO - ##### 22:26:41 INFO - ##### Running populate-webroot step. 22:26:41 INFO - ##### 22:26:41 INFO - Running pre-action listener: _resource_record_pre_action 22:26:41 INFO - Running main action method: populate_webroot 22:26:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:26:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:26:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:26:41 INFO - '--tppagecycles', 22:26:41 INFO - '7'], 22:26:41 INFO - 'tests': ['tsvgm']}}, 22:26:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:26:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:26:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:26:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:26:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:26:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:26:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:26:41 INFO - 'talos_options': ['--disable-e10s'], 22:26:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:26:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:26:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:26:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:26:41 INFO - 'talos_options': ['--disable-e10s'], 22:26:41 INFO - 'tests': ['damp', 'tps']}, 22:26:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:26:41 INFO - 'tests': ['damp', 'tps']}, 22:26:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:26:41 INFO - 'tests': ['dromaeo_dom']}, 22:26:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:26:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:26:41 INFO - 'tests': ['a11yr', 22:26:41 INFO - 'ts_paint', 22:26:41 INFO - 'tpaint', 22:26:41 INFO - 'sessionrestore', 22:26:41 INFO - 'sessionrestore_no_auto_restore', 22:26:41 INFO - 'tabpaint']}, 22:26:41 INFO - 'other-e10s': {'tests': ['a11yr', 22:26:41 INFO - 'ts_paint', 22:26:41 INFO - 'tpaint', 22:26:41 INFO - 'sessionrestore', 22:26:41 INFO - 'sessionrestore_no_auto_restore', 22:26:41 INFO - 'tabpaint']}, 22:26:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:26:41 INFO - 'ts_paint', 22:26:41 INFO - 'tpaint', 22:26:41 INFO - 'sessionrestore', 22:26:41 INFO - 'sessionrestore_no_auto_restore', 22:26:41 INFO - 'tabpaint']}, 22:26:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:26:41 INFO - 'ts_paint', 22:26:41 INFO - 'tpaint', 22:26:41 INFO - 'sessionrestore', 22:26:41 INFO - 'sessionrestore_no_auto_restore', 22:26:41 INFO - 'tabpaint']}, 22:26:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:26:41 INFO - 'tests': ['a11yr', 22:26:41 INFO - 'ts_paint', 22:26:41 INFO - 'tpaint', 22:26:41 INFO - 'sessionrestore', 22:26:41 INFO - 'sessionrestore_no_auto_restore', 22:26:41 INFO - 'tabpaint']}, 22:26:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:26:41 INFO - 'tests': ['a11yr', 22:26:41 INFO - 'ts_paint', 22:26:41 INFO - 'tpaint', 22:26:41 INFO - 'sessionrestore', 22:26:41 INFO - 'sessionrestore_no_auto_restore', 22:26:41 INFO - 'tabpaint']}, 22:26:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:26:41 INFO - 'tests': ['tsvgx', 22:26:41 INFO - 'tsvgr_opacity', 22:26:41 INFO - 'tart', 22:26:41 INFO - 'tscrollx', 22:26:41 INFO - 'cart']}, 22:26:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:26:41 INFO - 'tsvgr_opacity', 22:26:41 INFO - 'tart', 22:26:41 INFO - 'tscrollx', 22:26:41 INFO - 'cart']}, 22:26:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:26:41 INFO - 'talos_options': ['--disable-e10s'], 22:26:41 INFO - 'tests': ['tp5o']}, 22:26:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:26:41 INFO - 'tests': ['tp5o']}, 22:26:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:26:41 INFO - 'talos_options': ['--disable-e10s', 22:26:41 INFO - '--xperf_path', 22:26:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:26:41 INFO - 'tests': ['tp5n']}, 22:26:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:26:41 INFO - 'talos_options': ['--xperf_path', 22:26:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:26:41 INFO - 'tests': ['tp5n']}}, 22:26:41 INFO - 'talos.zip': {'path': '', 22:26:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:26:41 INFO - Running post-action listener: _resource_record_post_action 22:26:41 INFO - ##### 22:26:41 INFO - ##### Running create-virtualenv step. 22:26:41 INFO - ##### 22:26:41 INFO - Running pre-action listener: _resource_record_pre_action 22:26:41 INFO - Running main action method: create_virtualenv 22:26:41 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:26:41 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 22:26:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:26:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:26:42 INFO - Using real prefix '/usr' 22:26:42 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:26:42 INFO - Installing distribute.............................................................................................................................................................................................done. 22:26:44 INFO - Installing pip.................done. 22:26:44 INFO - Return code: 0 22:26:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:26: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')]} 22:26:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:26:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26: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')]} 22:26:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:26:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6ca6cf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19956b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19901d0>, '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 0x1993750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1993be0>, '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': '1f5564757af27664ca02d71f000001b0-1460610782.968931-43161327', '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 22:26:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 22:26:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:26:44 INFO - Using env: {'DISPLAY': ':0', 22:26:44 INFO - 'HOME': '/home/cltbld', 22:26:44 INFO - 'LANG': 'en_US.UTF-8', 22:26:44 INFO - 'LANGUAGE': 'en_US:en', 22:26:44 INFO - 'LOGNAME': 'cltbld', 22:26:44 INFO - 'MAIL': '/var/mail/cltbld', 22:26:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:26:44 INFO - 'MOZ_NO_REMOTE': '1', 22:26:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:26:44 INFO - 'NO_EM_RESTART': '1', 22:26:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:26:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:26:44 INFO - 'PWD': '/builds/slave/test-pgo', 22:26:44 INFO - 'SHELL': '/bin/bash', 22:26:44 INFO - 'SHLVL': '1', 22:26:44 INFO - 'TERM': 'linux', 22:26:44 INFO - 'TMOUT': '86400', 22:26:44 INFO - 'USER': 'cltbld', 22:26:44 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1460610782.968931-43161327', 22:26:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:26:44 INFO - '_': '/tools/buildbot/bin/python'} 22:26:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:26:44 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 22:26:44 INFO - Cleaning up... 22:26:44 INFO - Return code: 0 22:26:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:26: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')]} 22:26:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:26:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26: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')]} 22:26:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:26:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6ca6cf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19956b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19901d0>, '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 0x1993750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1993be0>, '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': '1f5564757af27664ca02d71f000001b0-1460610782.968931-43161327', '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 22:26:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 22:26:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 22:26:44 INFO - Using env: {'DISPLAY': ':0', 22:26:44 INFO - 'HOME': '/home/cltbld', 22:26:44 INFO - 'LANG': 'en_US.UTF-8', 22:26:44 INFO - 'LANGUAGE': 'en_US:en', 22:26:44 INFO - 'LOGNAME': 'cltbld', 22:26:44 INFO - 'MAIL': '/var/mail/cltbld', 22:26:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:26:44 INFO - 'MOZ_NO_REMOTE': '1', 22:26:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:26:44 INFO - 'NO_EM_RESTART': '1', 22:26:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:26:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:26:44 INFO - 'PWD': '/builds/slave/test-pgo', 22:26:44 INFO - 'SHELL': '/bin/bash', 22:26:44 INFO - 'SHLVL': '1', 22:26:44 INFO - 'TERM': 'linux', 22:26:44 INFO - 'TMOUT': '86400', 22:26:44 INFO - 'USER': 'cltbld', 22:26:44 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1460610782.968931-43161327', 22:26:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:26:44 INFO - '_': '/tools/buildbot/bin/python'} 22:26:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:26:45 INFO - Downloading/unpacking psutil>=0.7.1 22:26:45 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 22:26:45 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 22:26:45 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 22:26:45 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 22:26:45 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 22:26:45 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 22:26:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:26:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:26:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:26:47 INFO - Installing collected packages: psutil 22:26:47 INFO - Running setup.py install for psutil 22:26:47 INFO - building 'psutil._psutil_linux' extension 22:26:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 22:26:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 22:26:47 INFO - building 'psutil._psutil_posix' extension 22:26:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 22:26:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 22:26:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:26:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:26:47 INFO - Successfully installed psutil 22:26:47 INFO - Cleaning up... 22:26:47 INFO - Return code: 0 22:26:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:26: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')]} 22:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:26:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26: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')]} 22:26:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:26:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26:47 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 0x7f6ca6cf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19956b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19901d0>, '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 0x1993750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1993be0>, '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': '1f5564757af27664ca02d71f000001b0-1460610782.968931-43161327', '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 22:26:47 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 22:26:47 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 22:26:47 INFO - Using env: {'DISPLAY': ':0', 22:26:47 INFO - 'HOME': '/home/cltbld', 22:26:47 INFO - 'LANG': 'en_US.UTF-8', 22:26:47 INFO - 'LANGUAGE': 'en_US:en', 22:26:47 INFO - 'LOGNAME': 'cltbld', 22:26:47 INFO - 'MAIL': '/var/mail/cltbld', 22:26:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:26:47 INFO - 'MOZ_NO_REMOTE': '1', 22:26:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:26:47 INFO - 'NO_EM_RESTART': '1', 22:26:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:26:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:26:47 INFO - 'PWD': '/builds/slave/test-pgo', 22:26:47 INFO - 'SHELL': '/bin/bash', 22:26:47 INFO - 'SHLVL': '1', 22:26:47 INFO - 'TERM': 'linux', 22:26:47 INFO - 'TMOUT': '86400', 22:26:47 INFO - 'USER': 'cltbld', 22:26:47 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1460610782.968931-43161327', 22:26:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:26:47 INFO - '_': '/tools/buildbot/bin/python'} 22:26:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:26:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:26:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:26:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:26:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:26:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:26:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:26:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:26:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:26:49 INFO - Installing collected packages: mozsystemmonitor 22:26:49 INFO - Running setup.py install for mozsystemmonitor 22:26:49 INFO - Successfully installed mozsystemmonitor 22:26:49 INFO - Cleaning up... 22:26:49 INFO - Return code: 0 22:26:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:26:49 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')]} 22:26:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:26:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26:49 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')]} 22:26:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:26:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26:49 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 0x7f6ca6cf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19956b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19901d0>, '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 0x1993750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1993be0>, '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': '1f5564757af27664ca02d71f000001b0-1460610782.968931-43161327', '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 22:26:49 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 22:26:49 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 22:26:49 INFO - Using env: {'DISPLAY': ':0', 22:26:49 INFO - 'HOME': '/home/cltbld', 22:26:49 INFO - 'LANG': 'en_US.UTF-8', 22:26:49 INFO - 'LANGUAGE': 'en_US:en', 22:26:49 INFO - 'LOGNAME': 'cltbld', 22:26:49 INFO - 'MAIL': '/var/mail/cltbld', 22:26:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:26:49 INFO - 'MOZ_NO_REMOTE': '1', 22:26:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:26:49 INFO - 'NO_EM_RESTART': '1', 22:26:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:26:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:26:49 INFO - 'PWD': '/builds/slave/test-pgo', 22:26:49 INFO - 'SHELL': '/bin/bash', 22:26:49 INFO - 'SHLVL': '1', 22:26:49 INFO - 'TERM': 'linux', 22:26:49 INFO - 'TMOUT': '86400', 22:26:49 INFO - 'USER': 'cltbld', 22:26:49 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1460610782.968931-43161327', 22:26:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:26:49 INFO - '_': '/tools/buildbot/bin/python'} 22:26:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:26:50 INFO - Downloading/unpacking blobuploader==1.2.4 22:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:26:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:26:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:26:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:26:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:26:51 INFO - Downloading blobuploader-1.2.4.tar.gz 22:26:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:26:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:26: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 22:26: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 22:26: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 22:26: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 22:26: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 22:26: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 22:26:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:26:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:26:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:26:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:26:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:26:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:26:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:26:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:26:52 INFO - Downloading docopt-0.6.1.tar.gz 22:26:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:26:52 INFO - Installing collected packages: blobuploader, requests, docopt 22:26:52 INFO - Running setup.py install for blobuploader 22:26:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:26:52 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:26:52 INFO - Running setup.py install for requests 22:26:53 INFO - Running setup.py install for docopt 22:26:53 INFO - Successfully installed blobuploader requests docopt 22:26:53 INFO - Cleaning up... 22:26:53 INFO - Return code: 0 22:26:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:26:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:26:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:26:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:26:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:26:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6ca6cf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19956b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19901d0>, '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 0x1993750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1993be0>, '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': '1f5564757af27664ca02d71f000001b0-1460610782.968931-43161327', '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 22:26:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 22:26:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:26:53 INFO - Using env: {'DISPLAY': ':0', 22:26:53 INFO - 'HOME': '/home/cltbld', 22:26:53 INFO - 'LANG': 'en_US.UTF-8', 22:26:53 INFO - 'LANGUAGE': 'en_US:en', 22:26:53 INFO - 'LOGNAME': 'cltbld', 22:26:53 INFO - 'MAIL': '/var/mail/cltbld', 22:26:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:26:53 INFO - 'MOZ_NO_REMOTE': '1', 22:26:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:26:53 INFO - 'NO_EM_RESTART': '1', 22:26:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:26:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:26:53 INFO - 'PWD': '/builds/slave/test-pgo', 22:26:53 INFO - 'SHELL': '/bin/bash', 22:26:53 INFO - 'SHLVL': '1', 22:26:53 INFO - 'TERM': 'linux', 22:26:53 INFO - 'TMOUT': '86400', 22:26:53 INFO - 'USER': 'cltbld', 22:26:53 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1460610782.968931-43161327', 22:26:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:26:53 INFO - '_': '/tools/buildbot/bin/python'} 22:26:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:26:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:26:53 INFO - Running setup.py (path:/tmp/pip-1KD3hm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:26:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:26:53 INFO - Running setup.py (path:/tmp/pip-Cl1WWJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:26:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:26:53 INFO - Running setup.py (path:/tmp/pip-NyVXG8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:26:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:26:53 INFO - Running setup.py (path:/tmp/pip-wrWh5h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:26:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:26:53 INFO - Running setup.py (path:/tmp/pip-vKzoP7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:26:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:26:53 INFO - Running setup.py (path:/tmp/pip-O6XQZk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:26:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:26:53 INFO - Running setup.py (path:/tmp/pip-qcSI16-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:26:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:26:53 INFO - Running setup.py (path:/tmp/pip-3nsXhQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:26:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:26:54 INFO - Running setup.py (path:/tmp/pip-gLq_jJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:26:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:26:54 INFO - Running setup.py (path:/tmp/pip-WWR03f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:26:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:26:54 INFO - Running setup.py (path:/tmp/pip-e8VWvS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:26:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:26:54 INFO - Running setup.py (path:/tmp/pip-fdDXOo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:26:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:26:54 INFO - Running setup.py (path:/tmp/pip-sIdarb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:26:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:26:54 INFO - Running setup.py (path:/tmp/pip-nu4Cfe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:26:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:26:54 INFO - Running setup.py (path:/tmp/pip-LO5EXw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:26:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:26:54 INFO - Running setup.py (path:/tmp/pip-8lShIy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:26:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:26:54 INFO - Running setup.py (path:/tmp/pip-uMjGyi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:26:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:26:54 INFO - Running setup.py install for manifestparser 22:26:54 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:26:54 INFO - Running setup.py install for mozcrash 22:26:54 INFO - Running setup.py install for mozdebug 22:26:54 INFO - Running setup.py install for mozdevice 22:26:55 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:26:55 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:26:55 INFO - Running setup.py install for mozfile 22:26:55 INFO - Running setup.py install for mozhttpd 22:26:55 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:26:55 INFO - Running setup.py install for mozinfo 22:26:55 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:26:55 INFO - Running setup.py install for mozInstall 22:26:55 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:26:55 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:26:55 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:26:55 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:26:55 INFO - Running setup.py install for mozleak 22:26:55 INFO - Running setup.py install for mozlog 22:26:55 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:26:55 INFO - Running setup.py install for moznetwork 22:26:55 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:26:55 INFO - Running setup.py install for mozprocess 22:26:55 INFO - Running setup.py install for mozprofile 22:26:56 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:26:56 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:26:56 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:26:56 INFO - Running setup.py install for mozrunner 22:26:56 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:26:56 INFO - Running setup.py install for mozscreenshot 22:26:56 INFO - Running setup.py install for moztest 22:26:56 INFO - Running setup.py install for mozversion 22:26:56 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:26:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:26:56 INFO - Cleaning up... 22:26:56 INFO - Return code: 0 22:26:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:26:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:26:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:26:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:26:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6ca6cf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19956b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19901d0>, '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 0x1993750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1993be0>, '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': '1f5564757af27664ca02d71f000001b0-1460610782.968931-43161327', '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 22:26:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 22:26:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:26:56 INFO - Using env: {'DISPLAY': ':0', 22:26:56 INFO - 'HOME': '/home/cltbld', 22:26:56 INFO - 'LANG': 'en_US.UTF-8', 22:26:56 INFO - 'LANGUAGE': 'en_US:en', 22:26:56 INFO - 'LOGNAME': 'cltbld', 22:26:56 INFO - 'MAIL': '/var/mail/cltbld', 22:26:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:26:56 INFO - 'MOZ_NO_REMOTE': '1', 22:26:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:26:56 INFO - 'NO_EM_RESTART': '1', 22:26:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:26:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:26:56 INFO - 'PWD': '/builds/slave/test-pgo', 22:26:56 INFO - 'SHELL': '/bin/bash', 22:26:56 INFO - 'SHLVL': '1', 22:26:56 INFO - 'TERM': 'linux', 22:26:56 INFO - 'TMOUT': '86400', 22:26:56 INFO - 'USER': 'cltbld', 22:26:56 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1460610782.968931-43161327', 22:26:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:26:56 INFO - '_': '/tools/buildbot/bin/python'} 22:26:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:26:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:26:56 INFO - Running setup.py (path:/tmp/pip-PGRtTr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:26:56 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)) 22:26:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:26:56 INFO - Running setup.py (path:/tmp/pip-tWnoPY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:26:56 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)) 22:26:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:26:56 INFO - Running setup.py (path:/tmp/pip-eruwUE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:26:56 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)) 22:26:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:26:56 INFO - Running setup.py (path:/tmp/pip-GdkPkx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:26:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:26:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:26:57 INFO - Running setup.py (path:/tmp/pip-DuNUPV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:26:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 22:26:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:26:57 INFO - Running setup.py (path:/tmp/pip-Yoridk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:26:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 22:26:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:26:57 INFO - Running setup.py (path:/tmp/pip-Tr4Avs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:26:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 22:26:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:26:57 INFO - Running setup.py (path:/tmp/pip-IJWuSI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:26:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 22:26:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:26:57 INFO - Running setup.py (path:/tmp/pip-i6k94C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:26:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 22:26:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:26:57 INFO - Running setup.py (path:/tmp/pip-t5zJJk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:26:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:26:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:26:57 INFO - Running setup.py (path:/tmp/pip-cx2YUz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:26:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 22:26:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:26:57 INFO - Running setup.py (path:/tmp/pip-LCbgDE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:26:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 22:26:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:26:57 INFO - Running setup.py (path:/tmp/pip-_Efavt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:26:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 22:26:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:26:57 INFO - Running setup.py (path:/tmp/pip-uLUk07-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:26:57 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)) 22:26:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:26:57 INFO - Running setup.py (path:/tmp/pip-RnDgR_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:26:57 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)) 22:26:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:26:57 INFO - Running setup.py (path:/tmp/pip-4ITop4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:26:57 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)) 22:26:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:26:57 INFO - Running setup.py (path:/tmp/pip-qOaM1R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:26:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 22:26:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:26:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:26:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 22:26:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:26:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:26:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:26:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:26:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:26:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:26:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:26:59 INFO - Downloading blessings-1.6.tar.gz 22:26:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:26:59 INFO - Installing collected packages: blessings 22:26:59 INFO - Running setup.py install for blessings 22:27:00 INFO - Successfully installed blessings 22:27:00 INFO - Cleaning up... 22:27:00 INFO - Return code: 0 22:27:00 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:27:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:27:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:27:00 INFO - Reading from file tmpfile_stdout 22:27:00 INFO - Current package versions: 22:27:00 INFO - argparse == 1.2.1 22:27:00 INFO - blessings == 1.6 22:27:00 INFO - blobuploader == 1.2.4 22:27:00 INFO - docopt == 0.6.1 22:27:00 INFO - manifestparser == 1.1 22:27:00 INFO - mozInstall == 1.12 22:27:00 INFO - mozcrash == 0.17 22:27:00 INFO - mozdebug == 0.1 22:27:00 INFO - mozdevice == 0.48 22:27:00 INFO - mozfile == 1.2 22:27:00 INFO - mozhttpd == 0.7 22:27:00 INFO - mozinfo == 0.9 22:27:00 INFO - mozleak == 0.1 22:27:00 INFO - mozlog == 3.1 22:27:00 INFO - moznetwork == 0.27 22:27:00 INFO - mozprocess == 0.22 22:27:00 INFO - mozprofile == 0.28 22:27:00 INFO - mozrunner == 6.11 22:27:00 INFO - mozscreenshot == 0.1 22:27:00 INFO - mozsystemmonitor == 0.0 22:27:00 INFO - moztest == 0.7 22:27:00 INFO - mozversion == 1.4 22:27:00 INFO - psutil == 3.1.1 22:27:00 INFO - requests == 1.2.3 22:27:00 INFO - wsgiref == 0.1.2 22:27:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:27:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:27:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:27:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6ca6cf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19956b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19901d0>, '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 0x1993750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1993be0>, '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': '1f5564757af27664ca02d71f000001b0-1460610782.968931-43161327', '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 22:27:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 22:27:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:27:00 INFO - Using env: {'DISPLAY': ':0', 22:27:00 INFO - 'HOME': '/home/cltbld', 22:27:00 INFO - 'LANG': 'en_US.UTF-8', 22:27:00 INFO - 'LANGUAGE': 'en_US:en', 22:27:00 INFO - 'LOGNAME': 'cltbld', 22:27:00 INFO - 'MAIL': '/var/mail/cltbld', 22:27:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:00 INFO - 'MOZ_NO_REMOTE': '1', 22:27:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:27:00 INFO - 'NO_EM_RESTART': '1', 22:27:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:27:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:27:00 INFO - 'PWD': '/builds/slave/test-pgo', 22:27:00 INFO - 'SHELL': '/bin/bash', 22:27:00 INFO - 'SHLVL': '1', 22:27:00 INFO - 'TERM': 'linux', 22:27:00 INFO - 'TMOUT': '86400', 22:27:00 INFO - 'USER': 'cltbld', 22:27:00 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1460610782.968931-43161327', 22:27:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:00 INFO - '_': '/tools/buildbot/bin/python'} 22:27:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 22:27:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 22:27:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 22:27:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 22:27:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 22:27:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 22:27:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 22:27:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 22:27:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 22:27:00 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 22:27:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 22:27:00 INFO - Cleaning up... 22:27:00 INFO - Return code: 0 22:27:00 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:27:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:27:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:27:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6ca6cf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19956b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19901d0>, '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 0x1993750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1993be0>, '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': '1f5564757af27664ca02d71f000001b0-1460610782.968931-43161327', '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 22:27:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 22:27:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:27:00 INFO - Using env: {'DISPLAY': ':0', 22:27:00 INFO - 'HOME': '/home/cltbld', 22:27:00 INFO - 'LANG': 'en_US.UTF-8', 22:27:00 INFO - 'LANGUAGE': 'en_US:en', 22:27:00 INFO - 'LOGNAME': 'cltbld', 22:27:00 INFO - 'MAIL': '/var/mail/cltbld', 22:27:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:00 INFO - 'MOZ_NO_REMOTE': '1', 22:27:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:27:00 INFO - 'NO_EM_RESTART': '1', 22:27:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:27:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:27:00 INFO - 'PWD': '/builds/slave/test-pgo', 22:27:00 INFO - 'SHELL': '/bin/bash', 22:27:00 INFO - 'SHLVL': '1', 22:27:00 INFO - 'TERM': 'linux', 22:27:00 INFO - 'TMOUT': '86400', 22:27:00 INFO - 'USER': 'cltbld', 22:27:00 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1460610782.968931-43161327', 22:27:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:00 INFO - '_': '/tools/buildbot/bin/python'} 22:27:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:00 INFO - Downloading/unpacking jsonschema 22:27:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:27:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:27:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:27:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:27:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:27:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:27:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:27:02 INFO - Downloading/unpacking functools32 (from jsonschema) 22:27:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:27:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:27:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:27:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:27:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:27:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:27:02 INFO - Downloading functools32-3.2.3-2.tar.gz 22:27:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:27:02 INFO - warning: no files found matching '*.txt' 22:27:02 INFO - no previously-included directories found matching 'build' 22:27:02 INFO - no previously-included directories found matching 'dist' 22:27:02 INFO - no previously-included directories found matching '.git*' 22:27:02 INFO - Installing collected packages: jsonschema, functools32 22:27:03 INFO - Running setup.py install for functools32 22:27:03 INFO - warning: no files found matching '*.txt' 22:27:03 INFO - no previously-included directories found matching 'build' 22:27:03 INFO - no previously-included directories found matching 'dist' 22:27:03 INFO - no previously-included directories found matching '.git*' 22:27:03 INFO - Successfully installed jsonschema functools32 22:27:03 INFO - Cleaning up... 22:27:03 INFO - Return code: 0 22:27:03 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:27:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:27:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:27:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6ca6cf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19956b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19901d0>, '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 0x1993750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1993be0>, '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': '1f5564757af27664ca02d71f000001b0-1460610782.968931-43161327', '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 22:27:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 22:27:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:27:03 INFO - Using env: {'DISPLAY': ':0', 22:27:03 INFO - 'HOME': '/home/cltbld', 22:27:03 INFO - 'LANG': 'en_US.UTF-8', 22:27:03 INFO - 'LANGUAGE': 'en_US:en', 22:27:03 INFO - 'LOGNAME': 'cltbld', 22:27:03 INFO - 'MAIL': '/var/mail/cltbld', 22:27:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:03 INFO - 'MOZ_NO_REMOTE': '1', 22:27:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:27:03 INFO - 'NO_EM_RESTART': '1', 22:27:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:27:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:27:03 INFO - 'PWD': '/builds/slave/test-pgo', 22:27:03 INFO - 'SHELL': '/bin/bash', 22:27:03 INFO - 'SHLVL': '1', 22:27:03 INFO - 'TERM': 'linux', 22:27:03 INFO - 'TMOUT': '86400', 22:27:03 INFO - 'USER': 'cltbld', 22:27:03 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1460610782.968931-43161327', 22:27:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:03 INFO - '_': '/tools/buildbot/bin/python'} 22:27:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:03 INFO - Downloading/unpacking flake8 22:27:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:27:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:27:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:27:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:27:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:27:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:27:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:27:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:27:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:27:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:27:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:27:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:27:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:27:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:27:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:27:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:27:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:27:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:27:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:27:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:27:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:27:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:27:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:27:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:27:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:27:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:27:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:27:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:27:05 INFO - no previously-included directories found matching 'docs/_build' 22:27:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:27:06 INFO - Running setup.py install for pep8 22:27:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:27:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:27:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:27:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:27:06 INFO - no previously-included directories found matching 'docs/_build' 22:27:06 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:27:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:27:06 INFO - Cleaning up... 22:27:06 INFO - Return code: 0 22:27:06 INFO - Running post-action listener: _resource_record_post_action 22:27:06 INFO - Running post-action listener: _start_resource_monitoring 22:27:06 INFO - Starting resource monitoring. 22:27:06 INFO - ##### 22:27:06 INFO - ##### Running install step. 22:27:06 INFO - ##### 22:27:06 INFO - Running pre-action listener: _resource_record_pre_action 22:27:06 INFO - Running main action method: install 22:27:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:27:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:27:06 INFO - Reading from file tmpfile_stdout 22:27:06 INFO - Detecting whether we're running mozinstall >=1.0... 22:27:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:27:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:27:06 INFO - Reading from file tmpfile_stdout 22:27:06 INFO - Output received: 22:27:06 INFO - Usage: mozinstall [options] installer 22:27:06 INFO - Options: 22:27:06 INFO - -h, --help show this help message and exit 22:27:06 INFO - -d DEST, --destination=DEST 22:27:06 INFO - Directory to install application into. [default: 22:27:06 INFO - "/builds/slave/test-pgo"] 22:27:06 INFO - --app=APP Application being installed. [default: firefox] 22:27:06 INFO - mkdir: /builds/slave/test-pgo/build/application 22:27:06 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'] 22:27:06 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 22:27:22 INFO - Reading from file tmpfile_stdout 22:27:22 INFO - Output received: 22:27:22 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:27:22 INFO - Running post-action listener: _resource_record_post_action 22:27:22 INFO - ##### 22:27:22 INFO - ##### Running run-tests step. 22:27:22 INFO - ##### 22:27:22 INFO - Running pre-action listener: _resource_record_pre_action 22:27:22 INFO - Running main action method: run_tests 22:27:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:27:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:27:22 INFO - Python 2.7.3 22:27:22 INFO - Return code: 0 22:27:22 INFO - grabbing minidump binary from tooltool 22:27: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')]} 22:27:22 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19901d0>, '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 0x1993750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1993be0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:27:22 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 22:27:22 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 22:27:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:27:23 INFO - Return code: 0 22:27:23 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:27:23 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:27:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:27:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:27:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:27:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:27:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:27:24 INFO - Return code: 0 22:27:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SjZF20saQ5-MMJUDtEN1cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 22:27:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SjZF20saQ5-MMJUDtEN1cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --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 22:27:24 INFO - Using env: {'DISPLAY': ':0', 22:27:24 INFO - 'HOME': '/home/cltbld', 22:27:24 INFO - 'LANG': 'en_US.UTF-8', 22:27:24 INFO - 'LANGUAGE': 'en_US:en', 22:27:24 INFO - 'LOGNAME': 'cltbld', 22:27:24 INFO - 'MAIL': '/var/mail/cltbld', 22:27:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:27:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:27:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:24 INFO - 'MOZ_NO_REMOTE': '1', 22:27:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:27:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:27:24 INFO - 'NO_EM_RESTART': '1', 22:27:24 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:27:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:27:24 INFO - 'PWD': '/builds/slave/test-pgo', 22:27:24 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:27:24 INFO - 'SHELL': '/bin/bash', 22:27:24 INFO - 'SHLVL': '1', 22:27:24 INFO - 'TERM': 'linux', 22:27:24 INFO - 'TMOUT': '86400', 22:27:24 INFO - 'USER': 'cltbld', 22:27:24 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1460610782.968931-43161327', 22:27:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:24 INFO - '_': '/tools/buildbot/bin/python'} 22:27:24 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SjZF20saQ5-MMJUDtEN1cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 22:27:24 INFO - mozversion application_buildid: 20160413193308 22:27:24 INFO - mozversion application_changeset: 8630367f5e3f750e23cd04f309a1b279ff07e4a2 22:27:24 INFO - mozversion application_display_name: Nightly 22:27:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:27:24 INFO - mozversion application_name: Firefox 22:27:24 INFO - mozversion application_remotingname: firefox 22:27:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 22:27:24 INFO - mozversion application_vendor: Mozilla 22:27:24 INFO - mozversion application_version: 48.0a1 22:27:24 INFO - mozversion platform_buildid: 20160413193308 22:27:24 INFO - mozversion platform_changeset: 8630367f5e3f750e23cd04f309a1b279ff07e4a2 22:27:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 22:27:24 INFO - mozversion platform_version: 48.0a1 22:27:24 INFO - using testdate: 1460611644 22:27:24 INFO - actual date: 1460611644 22:27:24 INFO - starting webserver on 'localhost:51836' 22:27:24 INFO - SUITE-START | Running 2 tests 22:27:24 INFO - TEST-START | dromaeo_css 22:27:24 INFO - operating with platform_type : linux_ 22:27:24 INFO - Initialising browser for dromaeo_css test... 22:27:24 INFO - TEST-INFO | started process 20805 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpoVm_8k/profile http://localhost:51836/getInfo.html) 22:27:28 INFO - PROCESS | 20805 | __metrics Screen width/height:1600/1200 22:27:28 INFO - PROCESS | 20805 | colorDepth:24 22:27:28 INFO - PROCESS | 20805 | Browser inner width/height: 1024/697 22:27:28 INFO - PROCESS | 20805 | __metrics 22:27:29 ERROR - PROCESS | 20805 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:27:29 INFO - TEST-INFO | 20805: exit 0 22:27:29 INFO - Browser initialized. 22:27:29 INFO - Running cycle 1/1 for dromaeo_css test... 22:27:29 INFO - TEST-INFO | started process 20889 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpoVm_8k/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:27:41 INFO - PROCESS | 20889 | RSS: Main: 153100288 22:27:41 INFO - PROCESS | 20889 | 22:28:32 INFO - PROCESS | 20889 | 1460611712503 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] 22:30:39 INFO - PROCESS | 20889 | Cycle 1(1): loaded http://localhost:51836/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51836/tests/dromaeo/cssquery-ext.html) 22:30:40 INFO - PROCESS | 20889 | RSS: Main: 261763072 22:30:40 INFO - PROCESS | 20889 | 22:33:42 INFO - PROCESS | 20889 | Cycle 1(1): loaded http://localhost:51836/tests/dromaeo/cssquery-ext.html (next: http://localhost:51836/tests/dromaeo/cssquery-jquery.html) 22:33:43 INFO - PROCESS | 20889 | RSS: Main: 235765760 22:33:43 INFO - PROCESS | 20889 | 22:36:45 INFO - PROCESS | 20889 | Cycle 1(1): loaded http://localhost:51836/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51836/tests/dromaeo/cssquery-mootools.html) 22:36:46 INFO - PROCESS | 20889 | RSS: Main: 234545152 22:36:46 INFO - PROCESS | 20889 | 22:39:48 INFO - PROCESS | 20889 | Cycle 1(1): loaded http://localhost:51836/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51836/tests/dromaeo/cssquery-prototype.html) 22:39:48 INFO - PROCESS | 20889 | RSS: Main: 230002688 22:39:48 INFO - PROCESS | 20889 | 22:42:51 INFO - PROCESS | 20889 | Cycle 1(1): loaded http://localhost:51836/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51836/tests/dromaeo/cssquery-yui.html) 22:42:51 INFO - PROCESS | 20889 | RSS: Main: 214568960 22:42:51 INFO - PROCESS | 20889 | 22:45:54 INFO - PROCESS | 20889 | Cycle 1(1): loaded http://localhost:51836/tests/dromaeo/cssquery-yui.html (next: http://localhost:51836/tests/dromaeo/cssquery-dojo.html) 22:45:54 INFO - PROCESS | 20889 | RSS: Main: 264753152 22:45:54 INFO - PROCESS | 20889 | 22:45:54 INFO - PROCESS | 20889 | __start_tp_report 22:45:54 INFO - PROCESS | 20889 | _x_x_mozilla_page_load 22:45:54 INFO - PROCESS | 20889 | _x_x_mozilla_page_load_details 22:45:54 INFO - PROCESS | 20889 | |i|pagename|runs| 22:45:54 INFO - PROCESS | 20889 | |0;dojo.html;3073.0934374359563;3123.968760312399;3151.180693019814;3157.2106973256687;3180.348028654126;5070.645054846163;5173.042987047399;5176.223566465027;5190.8702282442955;5224.947750522494;5201.037808005522;5210.478952104788;5239.685618862871;5247.737613119348;5249.632525723201;4635.281531362627;4672.789724462399;4697;4742.620590352781;4761.976190119045;4640.466346370177;4756.548127927858;4783.593394561466;4808.110499557575;4815.951840481585;4673.509281525442;4720.64595155363;4748.311494833264;4751.477337492907;4764.380630518011;4643.721376717408;4646.117237724855;4655.2784318430695;4680.7191568506;4687.367205427292;4607.424071991001;4633.4208223972;4643.558861908114;4701.318308845232;4778.2115950868065;5065.4174769901565;5081.339425874649;5086.18621020635;5088.1350170471105;5115;5473.589480788957;5479.835604931858;5495.6153069285165;5495.807646732385;5543.168524721284;5380.7309634518115;5425.674459532401;5509.47659972302;5515.972420137874;5532.30846144232;5114.718690472023;5115.335006449175;5123.743812809382;5127.1796512558185;5127.410347809975;5553.8333849984565;5559;5560.694161821058;5564.248826408383;5573.470520300565;5269.446708095671;5300.549453296436;5306.708131052752;5358.3837858645975;5362.678239305654;5533.501984821385;5569.66582005081;5573.359063707644;5575.4424557543925;5580.386157522669;5374.758135883894;5511.641743286674;5549.472800083986;5554.1113421853115;5602.943970560243;5484.7531861066345;5529.972350138223;5560.694161821058;5577.9442205577425;5578.804741834017;4197.727147735387;4200.201961627281;4205.894852628648;4207.873763787091;4242.766647834337;3731.1045349116016;3788.1666033472593;3799.3351163546267;3806.307881355081;3828.157805282833;5192.506711862443;5212.035773381861;5218.556422704112;5228.346456692913;5258.8159414420315;5501.070344003632;5501.504864562208;5501.944980550144;5503.174523821459;5544.556435485151;5054.545090941833;5214;5222.582193424517;5227.529522342931;5310.522053015247;4750.144973904661;4751.1447939370555;4766.618670506351;4767.833125840579;4807.254875494234;5643.294588176478;5644.125160600113;5681.488666019995;5684.772609095672;5693.743781529841;5342;5534.695591742412;5545.972270138624;5639.407862174577;5661.716914154358;5649.406812284651;5667.03660377745;5676.262085928803;5685.232493613309;5688.829335119953;5396.757145928521;5417.6478528895495;5437.972810135924;5450.727463626724;5506.03644362243;5334.706591137525;5518.365387980273;5582.358028826737;5594.86012849682;5603.35561410443;5356.625036247426;5379.1662292344745;5381.381141168816;5383.892322153613;5384.946150538444;5266.236395722675;5299.2316114164005;5358.517733404013;5372.1941708744;5402.891942161214;5193.169092945111;5225.712585807817;5251.317328747391;5269.130593452038;5298.046351656739;5471.8084867029465;5513.917291240715;5520.834374968757;5520.889582208253;5520.972395137998;5085.415177254663;5277.868053298698;5380.569554435714;5400.540954018796;5446.046941785251 22:45:54 INFO - PROCESS | 20889 | |1;ext.html;609.3906093906094;652.5693042591889;656.4977791989132;665.6272487407051;668.3316683316681;29893;30279.394412111746;30286.242843928914;30630;35346.8232658837;38501.42247866284;39217.80391098041;39222.80388598053;39265.60734392655;39290.410643840296;8470.195331443503;8680.34897382699;8681.56592170389;8683;8685.218330350268;8386.245237928586;8475.660973561051;8497.830043399128;8500.192481714228;8501.532415717164;8509.787255318635;8804.987426445976;8809.735707928772;8814.294856411503;8815.823683526325;8678.956605216934;8681.392302538825;8682.565871706389;8714.694985675502;8752.256058235058;8752.081031491665;8854.468731876044;8863.955680221557;8876.934767827903;8895.110488951117;40136.59863401387;40644;40679.593204067874;40698;40743.18513629711;3446.8104254266004;3574.8391322390553;3576.8926932191816;3580;3644.0343309022865;29929.850350748107;30197.547036794465;30241.69758302433;30548.38903221923;31302.21744456384;4210.136921930997;4242.3788480263465;4257.8296868125235;4289.871303860889;4314.439122914033;268065;272172;272629;272730.999999998;272992;56422.15366769502;56701.716491417275;56996.430035699945;56997;57032.714836426385;57447;63967.680161598895;65821;65948.67025664842;66004;16792.580185495215;16869.409570664968;16882.15589220534;16950.915245423694;16957.49127526176;11769.293842369485;11899.821502677467;11921.34432606215;11961.162718609788;11992.340421276913;18336.81663183378;18897.905510472636;18982.81017189838;19134.425967221006;19147.8085219146;6781.525293229427;6809.795706128824;6982.301769822977;6990.679427272005;7025.665123626597;933.8365785987424;985.522021819417;1050.9894901051046;1070.8035475929173;1087.9945600272106;31869.68130318667;31896.681033189834;32207.838960805515;32657;32744.181395465304;1113.4432783608195;1134.4724703012973;1174.1780753472603;1213.8179273109104;1290.9677258068436;16693;17189.31242750276;17212.655746884993;17248.310067597155;17273.91363043177;474999;703281;719047;720270;722585;55980.72009640007;56631.43368566262;56936.86126277451;57117;57167.42832571704;1099.4612639806596;1186.1815347410432;1350.628577141294;1368.9657758556116;1379.7309524642799;29407.26481837971;32024.35951281008;32100.839495803306;32268.677313227505;32630.673693263714;44402.333964989906;44868.55131448644;45373.31940020836;45470.77264613656;45522.54477455183;282356;284399;285601.85995350283;286800;286898;25118.12086576961;25421.237362879143;25689.486210276064;25862.741372586785;27896;43569.346459802495;43609.56390436055;43888.561114389726;43940;44712.77643611761;35594.64405355913;36214;36601.81699091488;36693.816530917175;37154.628453715115;37592.62407375891;37840.243195135394;37874.431883522324;38047;38192.23615527618;38065.4290185653;38583.614163858;38755.80622096871;39195.41206881842;39550;32445.35109297848;33210.83394583012;33477.83261083679;34074.829625852704;34147.82926085453;26765.33086672771;26823.731762682124;27095.322616934733;27164.592531111655;27758.583621245292 22:45:54 INFO - PROCESS | 20889 | |2;jquery.html;387.4536902966817;387.89526827756504;389.7992533845069;399.6103798796174;402.07923854373485;14450.13299202046;17865.7320140198;18243.087845607715;18641.16114774835;18785.060746962667;17675.381361652344;17764;18338.358157464492;18864.622707545874;18941.14764835582;5547.55619550436;5621.943780562183;5674.148877668342;5704.8859022819515;5713.571482138836;4100.692448066392;5576.247206627094;5588.022096133181;5619.6066275360745;5869.442402971732;6117;6134.570580059375;6135.263768347782;6136.171616831737;6137.079438084278;6037.7584896604085;6100.969495152518;6113.388661133896;6115.541334399938;6123.5407344448895;5370.9731451342495;5555.638883472602;5561.77752889884;5566.997940370732;5589.301337332833;22097.337079887628;22317.888410558007;23096.53806923869;23151;23154.65268020981;2527.3428908483743;2540.453802432486;2612.9477410451686;2906.968026350636;3121.7034381733697;9246.676366327214;14013.229272390014;14089.225092619901;14211.78682319766;14534.418623255056;1930.9131089101024;1961.2743284984647;1983.6032793441225;2003.8396928245852;2046.467918341227;79462;83608.99999999939;83710;85026;85278.57360713219;10671.306365086244;10673.199510036779;10701.518431670593;10804.621838235624;10973.50619222137;12435.129540932228;13332.533361332307;15101.773473397909;15106.924465377602;15112;6172.197614310111;6235.127082208494;7229.710811567584;7891.960540197262;7977.401694872908;7313.707451701979;7468.551886886696;7528.360089392463;7562.016937798051;7702.9229707703325;4525.389072475174;4550.954490455053;4655.162070827216;4714;4818.373986177542;1853.2309091727052;1893.3751861885544;1928.2865339824355;1966.4788830959808;2002.8898410587558;902.7562558109405;932.2821427500786;940.3652534539159;1094.7372630568766;1103.0844399148687;19005.429837104908;19141.330053448062;19380.515487112934;19450;19535;915.9954200228956;921.4655499810228;922.280621115531;1027.5530144387214;1031.8555402243692;10335.586576537005;10535.894641053492;10566.404025296717;10914;11135.164862635334;442597;457185;464731;480048;481477;91660;92051.53974230085;92111;92384.53807730919;92600.53699731592;946.2382781860669;969.4231932000589;1054.847047178155;1073.8926107389198;1081.0756802933379;17229.39697110595;17234.482965511055;17390;17435.389761358292;17507;25135.69979107742;34170.31659366848;38720.41919371268;39394.40908386434;39877.20245595014;49265.75367123285;49662.25506617331;49771.50228497814;49974.750126249135;50730.74634626951;7458.993035940079;7765.7670269892;7947.403944704055;8258.504489730636;8401.411901166859;9359.859602105838;12592;13428.39572219233;13442.327883605585;13490.190588564717;11346.773064538498;11534.94232528832;11562;11641;11901.82147267809;11081.889181108085;11742.412879355827;11753.823692644788;11968.880311197125;11975.880241197476;11632.360220187971;11756.647300580997;11867.490353665551;11924.701882453008;11999.64001079969;8074.071481779671;8163.877541836759;8280.751577452686;8513.489190648581;8546.957265213883;10142.898571014195;11982.700432489257;12121.575744848888;12214.26714397139;12230.755384892074 22:45:54 INFO - PROCESS | 20889 | |3;mootools.html;1253.7367152897891;1287.3756228229313;1333.3466601365335;1383.391307824557;1480.0453707358754;7681.116671582763;8016.879746803788;8021.558814265206;8029.036515618127;8040.557769322685;7765.18465561115;7919.920800791991;7921.207879212076;7929.326007289373;7934.1272460029495;2005.5788284460282;2287.4853158039473;2306.6770652108676;2329.8369114161933;2377.738448770634;2342.3441436397834;2365.1603680693365;2366.4320563064825;2367.1951536477595;2368.0291080656934;2294.5181511882442;2344.742078371378;2346.190564255338;2346.2374728213313;2349.107339211106;2024.8177664010236;2234.519578290667;2299.850509716863;2301.8503797253125;2304.68886700295;2217.8558393704357;2220.11195521791;2227.7438094619;2227.9108835646553;2260.0168926517017;7969.163237859999;8039.397045221632;8155.836883262361;8165.101838797727;8244.216799404046;4968.279599458058;5111.539961403454;5140.997505486432;5154.587632989352;5160.071187186305;3151.6533181350032;3179.761517886168;3221.919452013695;3245.2860370718404;3248.2691394436297;1077.3374374759467;1102.9944850275776;1103.0623969625833;1128.368113856243;1131.185546406586;11087.2238943274;11098.167637427225;11106.389148596823;11111.499982500725;11127.66617001483;4400.273954797422;4433.534478879736;4524.9095018100115;4612.07758448305;4616.930746038812;9054.094590541024;9055.818883622422;9064.184223419923;9073.546322683971;9084.18242358191;4633.72197668141;5070.366204224472;5093.8726531837;5116.565091967224;5129.461406552333;4669.836555720533;4750.809967601326;4754;4757.881052973703;4797.64017698674;3801.3917773156163;3830.19565891166;3922.0783115967724;3930.449737036817;3947.743396679207;1266.0820904843915;1283.076185146693;1284.3064745037761;1287.5493577248076;1307.1634154141357;949.4493193947494;966.8211380894558;978.7406337320616;983.1852412639058;987.9061489158519;5531.25328080712;5755.568332375088;5786.833479894469;5802.390748971382;5823.184754134425;415.83158820677676;429.19097501210445;432.12710325143036;439.973601583906;446.32827594470115;4096.91806163875;4154.459920210414;4166.500019997619;4173.728707633994;4177.248095342868;10069.395836249849;10479.266451348485;10553.63062292816;10558.947205263925;10572.788544229226;10250.128739057114;10371.585136594602;10406.531706073245;10414.843777343345;10417.062464378243;7482.176960534228;7826.530408175528;7849.9215007850335;7939.563324017119;7961.840763184704;5658.151277308437;5714.285714285715;5729.770809167587;5737.91393129095;5847.649141051551;9191.94292656353;9284.814303714023;9407.85888211691;9412.905870941204;9524.190443812353;9457.952710236405;9568.665096721581;9579.329446938647;9629.518524073908;9707.417554946725;6826.488013398915;7054.964725176341;7225.277472252733;7391.2239214881665;7695.076590809139;8171.959140204499;8178.550179740171;8245;8253.215944485264;8264.710735124241;6933.583984960918;7142;7168.89246661311;7207.243239459781;7340.302671246223;7418.035655364768;7430.554166750012;7474.2525747424825;7504;7550.962245188739;6741.089952856301;6778.728850846108;6816.591004539743;6818.249992500921;6829.556078854858;5005.299258103795;5023.447420783637;5025.47232540578;5032.245163225399;5039.773210205476;5109.1059064662795;5141.562967147835;5172.922406163835;5189.221616757365;5313.1764576490705 22:45:54 INFO - PROCESS | 20889 | |4;prototype.html;314.39479002919376;320.7946913975055;328.7435800075942;335.94624860022395;341.9760616756827;5389.622726409153;5555.805546805863;5609.074502707053;5665.3768085510565;5687.943120568798;5590.217369568264;5614.259579530339;5627.099664053742;5647.068233741438;5668.178114173443;4351.151525452538;4351.195028919644;4357.411749413836;4357.869263922087;4378.540253273408;4218.957810421903;4334.284843000901;4351;4351.6953813233085;4378.233809083414;4304.483461984566;4309.806058727349;4310.310350343945;4314.503832059307;4314.84898028569;4301.698881078326;4322.935155972663;4324.729517003567;4340.717853339523;4348.695591308594;3712.6472985066644;3742.502365067361;3792.6396992285963;3799.1072098056934;3805.2389522095414;5383.811566595189;5419.132938729785;5423.159410291411;5432.049391356497;5443.421407791775;4893.75531223441;4923.089228492705;4937.925931111036;4951.900961980777;4993.176125939216;5601.383847776741;5809.912851307234;5864.091065884794;5899.852503687399;5909.099994003936;4141.751494910285;4177.707560470738;4180.435641188431;4181.581841815824;4186.120914607905;6093.786717464912;6133.1106989486725;6142.8771424571705;6144.41628045335;6151.231096112986;4177.394277829698;4256.403848556791;4273.572642735764;4275.251830929575;4293.91412171761;4309.569043095728;4322.502912165079;4327.437433133672;4348.826046958149;4350.73895566267;4951.06908305761;4956.231784073474;4968.72672003036;4970.403551573834;4973.5523802857915;5722.227499287543;5890.8821823563285;5891.3814049525035;5930.22907022093;5943.613665111754;1459.8540145985316;1468.544751127154;1474.800901878254;1474.837767845536;1481.8147731533559;973.3429934793986;977.3940157102642;990.1633120013577;990.5641517732175;1026.384169498295;5742.913856292159;5749.338826034976;5754.539636829044;5763.4812866842185;5764.5676574257095;5978;5978.581499295007;5996.430339117776;6018.337982821886;6033.728482218311;5503.532199762985;5670.432956704297;5688.374278829326;5689.175069614883;5697.088465845528;3202.647708752035;3207.5028370602595;3233;3238.757093218018;3262.8368581570826;6101.145839582462;6221.8133455995485;6285.748570057147;6287.622742635456;6307.24313082433;6209.192804935329;6227.439530442282;6231.189945307081;6248.937510624926;6265.498760099181;6259.18630578031;6270.435660790551;6275.341089185661;6295.98528470885;6304.148939893055;5792.536597072309;6016.187814645142;6018.849528761816;6022.638641681513;6040.426159514839;5938.079597662369;5968.343482217039;6012.128241405059;6031;6037.547183961133;6053.364396738279;6081.756729730938;6287.245530536182;6293;6304.873902522016;4161.8959526012095;4288.614024737789;4294.398784170281;4298.806553705028;4302.268614335508;6048.969755151196;6076.544259180668;6100.420460056288;6102.877942441215;6140.355262697352;5815.33123690764;5914.142449344907;5948.553858460719;5973.820785376446;5977;5860.15027820955;5916.970415147896;5924.62296490996;5931.377205393372;5963.2844058713235;5835;5847.239858818497;5850.151727999331;5868.354481007001;5869.882602347844;5745.798897038583;6018.8194354169445;6030.4572588467245;6044.607100538451;6048.274207095177;5848.298204215522;5855.151003104611;5884.146493854593;5892.292924849045;5927.644341339534 22:45:54 INFO - PROCESS | 20889 | |5;yui.html;728.5519405565578;796.8246985663154;807.6527093349857;849.7153453593046;852.2585350744849;14313.642158946019;14522.927385363058;14548.92725536371;14603.12381257124;14610.415583376665;12585.307808070553;12687.365631718423;12688.555900543482;12695.428705708242;12703.301318427482;647.0908373734886;780.5394817057935;781.88271759236;801.3869389916689;804.0672819529348;780.637003793236;787.6652422720349;787.8621241282781;789.1753117991684;793.0602236349915;841.3899922556159;841.970531031414;842.3008902610849;844.0799528513919;850.3579797253066;682.9931700682979;829.4401279136558;848.753861380199;851.4891065360796;851.7231899632583;623.5510432488646;624.5347216323868;624.6221036273034;624.8156793745856;624.8750249949983;13149.605511834565;13162.14446061003;13171.73656526864;13214.339283035906;13222.206667599974;13131.34343282832;13213.075084744072;13223.140495867738;13578.117422367613;13820.861791382058;10943.179261555415;10985.176111791647;11063.170262230366;11135;11213.102951763922;3712.109093817491;3755.47423360727;3759.7368184227116;3777.9433308500393;3800.429935509668;55600;57659.71170144164;57693.423065769646;57722;57985;10364.844527332096;10699.83950240747;10726.356418614909;10746.73133171677;11024.779504409868;18464.35374761877;18889;18910.62178756417;18922.62154756897;18929.621407571773;8130;8169.346452283803;8229.670813167406;8288.088310285864;8342.916570834213;4595.035042641083;4666.87994881226;4680.180968330528;4731.834385796549;4739.431268247763;3202.1834432219634;3309.2223327518013;3309.8014119152444;3311.8675252990092;3325.6840600142946;593.4955288005161;611.8225714542822;616.2743150884985;653.8430776613578;661.5567569728294;616.6926116632767;664.9202095748444;667.893137098062;674.2078058281597;679.6907407129744;8717.607707653044;8914.193810994037;9278.768030799149;9448.811023779623;9474.573644186028;577.6245440463732;664.9202095748444;667.9365460281266;685.3454950522339;691.260212923991;4342.217330019452;4356.172327257811;4376.693631445768;4451.087527056946;4461.330800379904;52469;54137.72931135398;69806.30193697997;69924;70025.64987175031;51545.22682159771;51849.48150518522;52849.207261891104;53185.46814531805;53589.196162057604;44530.777346112416;47985.28022079672;48349.75825120852;48530;49041.754791225816;9113.544322783702;9129.132732390412;9157.908420915706;9180.17378435944;9367.484788336707;32883.177920552174;33111.33777324488;33506;33733.83133084319;33803.492947605315;42333.36499952441;44999.100018000114;46181.30728039015;46454.53545464502;46753.29870051884;10386.37681739068;10473.790524189626;11257.549698011988;11591.6522504325;11826.76346473083;13191.274479903697;13447.663808404868;13477.595672129852;13752.518661847187;14269.42922283097;12467.812982805084;12766.297853617769;12857.164284321489;12956.222626642431;13030.348482576022;12088.15382923187;12199.756004879675;12423.503059877865;12432.12975091735;12442.129050966345;12572.182808117443;12626.242425454502;12712.74574508523;12889.09776315649;13334.533291334757;10653.307535010199;10805.405702686428;10843.295185812896;10898.40058796742;11082.667519974413;11118.38848863288;11150.219484635998;11208.943955280172;11213.215074944676;11215.60745373908 22:45:54 INFO - PROCESS | 20889 | __end_tp_report 22:45:54 INFO - PROCESS | 20889 | __start_cc_report 22:45:54 INFO - PROCESS | 20889 | _x_x_mozilla_cycle_collect,841 22:45:54 INFO - PROCESS | 20889 | __end_cc_report 22:45:54 INFO - PROCESS | 20889 | __startTimestamp1460612754409__endTimestamp 22:45:54 INFO - PROCESS | 20889 | 22:45:54 INFO - PROCESS | 20889 | ------- Summary: start ------- 22:45:54 INFO - PROCESS | 20889 | Number of tests: 6 22:45:54 INFO - PROCESS | 20889 | 22:45:54 INFO - PROCESS | 20889 | [#0] dojo.html Cycles:165 Average:5124.65 Median:5298.05 stddev:557.75 (10.5%) stddev-sans-first:535.73 22:45:54 INFO - PROCESS | 20889 | Values: 3073.1 3124.0 3151.2 3157.2 3180.3 5070.6 5173.0 5176.2 5190.9 5224.9 5201.0 5210.5 5239.7 5247.7 5249.6 4635.3 4672.8 4697.0 4742.6 4762.0 4640.5 4756.5 4783.6 4808.1 4816.0 4673.5 4720.6 4748.3 4751.5 4764.4 4643.7 4646.1 4655.3 4680.7 4687.4 4607.4 4633.4 4643.6 4701.3 4778.2 5065.4 5081.3 5086.2 5088.1 5115.0 5473.6 5479.8 5495.6 5495.8 5543.2 5380.7 5425.7 5509.5 5516.0 5532.3 5114.7 5115.3 5123.7 5127.2 5127.4 5553.8 5559.0 5560.7 5564.2 5573.5 5269.4 5300.5 5306.7 5358.4 5362.7 5533.5 5569.7 5573.4 5575.4 5580.4 5374.8 5511.6 5549.5 5554.1 5602.9 5484.8 5530.0 5560.7 5577.9 5578.8 4197.7 4200.2 4205.9 4207.9 4242.8 3731.1 3788.2 3799.3 3806.3 3828.2 5192.5 5212.0 5218.6 5228.3 5258.8 5501.1 5501.5 5501.9 5503.2 5544.6 5054.5 5214.0 5222.6 5227.5 5310.5 4750.1 4751.1 4766.6 4767.8 4807.3 5643.3 5644.1 5681.5 5684.8 5693.7 5342.0 5534.7 5546.0 5639.4 5661.7 5649.4 5667.0 5676.3 5685.2 5688.8 5396.8 5417.6 5438.0 5450.7 5506.0 5334.7 5518.4 5582.4 5594.9 5603.4 5356.6 5379.2 5381.4 5383.9 5384.9 5266.2 5299.2 5358.5 5372.2 5402.9 5193.2 5225.7 5251.3 5269.1 5298.0 5471.8 5513.9 5520.8 5520.9 5521.0 5085.4 5277.9 5380.6 5400.5 5446.0 22:45:54 INFO - PROCESS | 20889 | 22:45:54 INFO - PROCESS | 20889 | [#1] ext.html Cycles:180 Average:56215.15 Median:37960.72 stddev:121332.99 (319.6%) stddev-sans-first:121601.53 22:45:54 INFO - PROCESS | 20889 | Values: 609.4 652.6 656.5 665.6 668.3 29893.0 30279.4 30286.2 30630.0 35346.8 38501.4 39217.8 39222.8 39265.6 39290.4 8470.2 8680.3 8681.6 8683.0 8685.2 8386.2 8475.7 8497.8 8500.2 8501.5 8509.8 8805.0 8809.7 8814.3 8815.8 8679.0 8681.4 8682.6 8714.7 8752.3 8752.1 8854.5 8864.0 8876.9 8895.1 40136.6 40644.0 40679.6 40698.0 40743.2 3446.8 3574.8 3576.9 3580.0 3644.0 29929.9 30197.5 30241.7 30548.4 31302.2 4210.1 4242.4 4257.8 4289.9 4314.4 268065.0 272172.0 272629.0 272731.0 272992.0 56422.2 56701.7 56996.4 56997.0 57032.7 57447.0 63967.7 65821.0 65948.7 66004.0 16792.6 16869.4 16882.2 16950.9 16957.5 11769.3 11899.8 11921.3 11961.2 11992.3 18336.8 18897.9 18982.8 19134.4 19147.8 6781.5 6809.8 6982.3 6990.7 7025.7 933.8 985.5 1051.0 1070.8 1088.0 31869.7 31896.7 32207.8 32657.0 32744.2 1113.4 1134.5 1174.2 1213.8 1291.0 16693.0 17189.3 17212.7 17248.3 17273.9 474999.0 703281.0 719047.0 720270.0 722585.0 55980.7 56631.4 56936.9 57117.0 57167.4 1099.5 1186.2 1350.6 1369.0 1379.7 29407.3 32024.4 32100.8 32268.7 32630.7 44402.3 44868.6 45373.3 45470.8 45522.5 282356.0 284399.0 285601.9 286800.0 286898.0 25118.1 25421.2 25689.5 25862.7 27896.0 43569.3 43609.6 43888.6 43940.0 44712.8 35594.6 36214.0 36601.8 36693.8 37154.6 37592.6 37840.2 37874.4 38047.0 38192.2 38065.4 38583.6 38755.8 39195.4 39550.0 32445.4 33210.8 33477.8 34074.8 34147.8 26765.3 26823.7 27095.3 27164.6 27758.6 22:45:54 INFO - PROCESS | 20889 | 22:45:54 INFO - PROCESS | 20889 | [#2] jquery.html Cycles:180 Average:27890.29 Median:18646.01 stddev:76856.49 (412.2%) stddev-sans-first:77044.35 22:45:54 INFO - PROCESS | 20889 | Values: 387.5 387.9 389.8 399.6 402.1 14450.1 17865.7 18243.1 18641.2 18785.1 17675.4 17764.0 18338.4 18864.6 18941.1 5547.6 5621.9 5674.1 5704.9 5713.6 4100.7 5576.2 5588.0 5619.6 5869.4 6117.0 6134.6 6135.3 6136.2 6137.1 6037.8 6101.0 6113.4 6115.5 6123.5 5371.0 5555.6 5561.8 5567.0 5589.3 22097.3 22317.9 23096.5 23151.0 23154.7 2527.3 2540.5 2612.9 2907.0 3121.7 9246.7 14013.2 14089.2 14211.8 14534.4 1930.9 1961.3 1983.6 2003.8 2046.5 79462.0 83609.0 83710.0 85026.0 85278.6 10671.3 10673.2 10701.5 10804.6 10973.5 12435.1 13332.5 15101.8 15106.9 15112.0 6172.2 6235.1 7229.7 7892.0 7977.4 7313.7 7468.6 7528.4 7562.0 7702.9 4525.4 4551.0 4655.2 4714.0 4818.4 1853.2 1893.4 1928.3 1966.5 2002.9 902.8 932.3 940.4 1094.7 1103.1 19005.4 19141.3 19380.5 19450.0 19535.0 916.0 921.5 922.3 1027.6 1031.9 10335.6 10535.9 10566.4 10914.0 11135.2 442597.0 457185.0 464731.0 480048.0 481477.0 91660.0 92051.5 92111.0 92384.5 92600.5 946.2 969.4 1054.8 1073.9 1081.1 17229.4 17234.5 17390.0 17435.4 17507.0 25135.7 34170.3 38720.4 39394.4 39877.2 49265.8 49662.3 49771.5 49974.8 50730.7 7459.0 7765.8 7947.4 8258.5 8401.4 9359.9 12592.0 13428.4 13442.3 13490.2 11346.8 11534.9 11562.0 11641.0 11901.8 11081.9 11742.4 11753.8 11968.9 11975.9 11632.4 11756.6 11867.5 11924.7 11999.6 8074.1 8163.9 8280.8 8513.5 8547.0 10142.9 11982.7 12121.6 12214.3 12230.8 22:45:54 INFO - PROCESS | 20889 | 22:45:54 INFO - PROCESS | 20889 | [#3] mootools.html Cycles:180 Average:5486.19 Median:5036.01 stddev:3041.91 (60.4%) stddev-sans-first:3033.81 22:45:54 INFO - PROCESS | 20889 | Values: 1253.7 1287.4 1333.3 1383.4 1480.0 7681.1 8016.9 8021.6 8029.0 8040.6 7765.2 7919.9 7921.2 7929.3 7934.1 2005.6 2287.5 2306.7 2329.8 2377.7 2342.3 2365.2 2366.4 2367.2 2368.0 2294.5 2344.7 2346.2 2346.2 2349.1 2024.8 2234.5 2299.9 2301.9 2304.7 2217.9 2220.1 2227.7 2227.9 2260.0 7969.2 8039.4 8155.8 8165.1 8244.2 4968.3 5111.5 5141.0 5154.6 5160.1 3151.7 3179.8 3221.9 3245.3 3248.3 1077.3 1103.0 1103.1 1128.4 1131.2 11087.2 11098.2 11106.4 11111.5 11127.7 4400.3 4433.5 4524.9 4612.1 4616.9 9054.1 9055.8 9064.2 9073.5 9084.2 4633.7 5070.4 5093.9 5116.6 5129.5 4669.8 4750.8 4754.0 4757.9 4797.6 3801.4 3830.2 3922.1 3930.4 3947.7 1266.1 1283.1 1284.3 1287.5 1307.2 949.4 966.8 978.7 983.2 987.9 5531.3 5755.6 5786.8 5802.4 5823.2 415.8 429.2 432.1 440.0 446.3 4096.9 4154.5 4166.5 4173.7 4177.2 10069.4 10479.3 10553.6 10558.9 10572.8 10250.1 10371.6 10406.5 10414.8 10417.1 7482.2 7826.5 7849.9 7939.6 7961.8 5658.2 5714.3 5729.8 5737.9 5847.6 9191.9 9284.8 9407.9 9412.9 9524.2 9458.0 9568.7 9579.3 9629.5 9707.4 6826.5 7055.0 7225.3 7391.2 7695.1 8172.0 8178.6 8245.0 8253.2 8264.7 6933.6 7142.0 7168.9 7207.2 7340.3 7418.0 7430.6 7474.3 7504.0 7551.0 6741.1 6778.7 6816.6 6818.2 6829.6 5005.3 5023.4 5025.5 5032.2 5039.8 5109.1 5141.6 5172.9 5189.2 5313.2 22:45:54 INFO - PROCESS | 20889 | 22:45:54 INFO - PROCESS | 20889 | [#4] prototype.html Cycles:180 Average:4958.39 Median:5693.13 stddev:1477.32 (25.9%) stddev-sans-first:1439.75 22:45:54 INFO - PROCESS | 20889 | Values: 314.4 320.8 328.7 335.9 342.0 5389.6 5555.8 5609.1 5665.4 5687.9 5590.2 5614.3 5627.1 5647.1 5668.2 4351.2 4351.2 4357.4 4357.9 4378.5 4219.0 4334.3 4351.0 4351.7 4378.2 4304.5 4309.8 4310.3 4314.5 4314.8 4301.7 4322.9 4324.7 4340.7 4348.7 3712.6 3742.5 3792.6 3799.1 3805.2 5383.8 5419.1 5423.2 5432.0 5443.4 4893.8 4923.1 4937.9 4951.9 4993.2 5601.4 5809.9 5864.1 5899.9 5909.1 4141.8 4177.7 4180.4 4181.6 4186.1 6093.8 6133.1 6142.9 6144.4 6151.2 4177.4 4256.4 4273.6 4275.3 4293.9 4309.6 4322.5 4327.4 4348.8 4350.7 4951.1 4956.2 4968.7 4970.4 4973.6 5722.2 5890.9 5891.4 5930.2 5943.6 1459.9 1468.5 1474.8 1474.8 1481.8 973.3 977.4 990.2 990.6 1026.4 5742.9 5749.3 5754.5 5763.5 5764.6 5978.0 5978.6 5996.4 6018.3 6033.7 5503.5 5670.4 5688.4 5689.2 5697.1 3202.6 3207.5 3233.0 3238.8 3262.8 6101.1 6221.8 6285.7 6287.6 6307.2 6209.2 6227.4 6231.2 6248.9 6265.5 6259.2 6270.4 6275.3 6296.0 6304.1 5792.5 6016.2 6018.8 6022.6 6040.4 5938.1 5968.3 6012.1 6031.0 6037.5 6053.4 6081.8 6287.2 6293.0 6304.9 4161.9 4288.6 4294.4 4298.8 4302.3 6049.0 6076.5 6100.4 6102.9 6140.4 5815.3 5914.1 5948.6 5973.8 5977.0 5860.2 5917.0 5924.6 5931.4 5963.3 5835.0 5847.2 5850.2 5868.4 5869.9 5745.8 6018.8 6030.5 6044.6 6048.3 5848.3 5855.2 5884.1 5892.3 5927.6 22:45:54 INFO - PROCESS | 20889 | 22:45:54 INFO - PROCESS | 20889 | [#5] yui.html Cycles:180 Average:14668.31 Median:24496.05 stddev:17116.31 (69.9%) stddev-sans-first:17132.32 22:45:54 INFO - PROCESS | 20889 | Values: 728.6 796.8 807.7 849.7 852.3 14313.6 14522.9 14548.9 14603.1 14610.4 12585.3 12687.4 12688.6 12695.4 12703.3 647.1 780.5 781.9 801.4 804.1 780.6 787.7 787.9 789.2 793.1 841.4 842.0 842.3 844.1 850.4 683.0 829.4 848.8 851.5 851.7 623.6 624.5 624.6 624.8 624.9 13149.6 13162.1 13171.7 13214.3 13222.2 13131.3 13213.1 13223.1 13578.1 13820.9 10943.2 10985.2 11063.2 11135.0 11213.1 3712.1 3755.5 3759.7 3777.9 3800.4 55600.0 57659.7 57693.4 57722.0 57985.0 10364.8 10699.8 10726.4 10746.7 11024.8 18464.4 18889.0 18910.6 18922.6 18929.6 8130.0 8169.3 8229.7 8288.1 8342.9 4595.0 4666.9 4680.2 4731.8 4739.4 3202.2 3309.2 3309.8 3311.9 3325.7 593.5 611.8 616.3 653.8 661.6 616.7 664.9 667.9 674.2 679.7 8717.6 8914.2 9278.8 9448.8 9474.6 577.6 664.9 667.9 685.3 691.3 4342.2 4356.2 4376.7 4451.1 4461.3 52469.0 54137.7 69806.3 69924.0 70025.6 51545.2 51849.5 52849.2 53185.5 53589.2 44530.8 47985.3 48349.8 48530.0 49041.8 9113.5 9129.1 9157.9 9180.2 9367.5 32883.2 33111.3 33506.0 33733.8 33803.5 42333.4 44999.1 46181.3 46454.5 46753.3 10386.4 10473.8 11257.5 11591.7 11826.8 13191.3 13447.7 13477.6 13752.5 14269.4 12467.8 12766.3 12857.2 12956.2 13030.3 12088.2 12199.8 12423.5 12432.1 12442.1 12572.2 12626.2 12712.7 12889.1 13334.5 10653.3 10805.4 10843.3 10898.4 11082.7 11118.4 11150.2 11208.9 11213.2 11215.6 22:45:54 INFO - PROCESS | 20889 | -------- Summary: end -------- 22:45:54 INFO - PROCESS | 20889 | 22:45:55 INFO - TEST-INFO | 20889: exit 0 22:45:55 INFO - TEST-OK | dromaeo_css | took 1110846ms 22:45:55 INFO - TEST-START | kraken 22:45:55 INFO - operating with platform_type : linux_ 22:45:55 INFO - Initialising browser for kraken test... 22:45:55 INFO - TEST-INFO | started process 21065 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpanywBK/profile http://localhost:51836/getInfo.html) 22:45:58 INFO - PROCESS | 21065 | __metrics Screen width/height:1600/1200 22:45:58 INFO - PROCESS | 21065 | colorDepth:24 22:45:58 INFO - PROCESS | 21065 | Browser inner width/height: 1024/697 22:45:58 INFO - PROCESS | 21065 | __metrics 22:45:59 ERROR - PROCESS | 21065 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:46:00 INFO - TEST-INFO | 21065: exit 0 22:46:00 INFO - Browser initialized. 22:46:00 INFO - Running cycle 1/1 for kraken test... 22:46:00 INFO - TEST-INFO | started process 21147 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpanywBK/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:46:12 INFO - PROCESS | 21147 | RSS: Main: 153526272 22:46:12 INFO - PROCESS | 21147 | 22:46:14 INFO - PROCESS | 21147 | Cycle 1(1): loaded http://localhost:51836/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51836/tests/kraken/driver.html?testName=audio-beat-detection) 22:46:15 INFO - PROCESS | 21147 | RSS: Main: 208068608 22:46:15 INFO - PROCESS | 21147 | 22:46:18 INFO - PROCESS | 21147 | Cycle 1(1): loaded http://localhost:51836/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51836/tests/kraken/driver.html?testName=audio-dft) 22:46:19 INFO - PROCESS | 21147 | RSS: Main: 193773568 22:46:19 INFO - PROCESS | 21147 | 22:46:22 INFO - PROCESS | 21147 | Cycle 1(1): loaded http://localhost:51836/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51836/tests/kraken/driver.html?testName=audio-fft) 22:46:22 INFO - PROCESS | 21147 | RSS: Main: 263716864 22:46:22 INFO - PROCESS | 21147 | 22:46:24 INFO - PROCESS | 21147 | Cycle 1(1): loaded http://localhost:51836/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51836/tests/kraken/driver.html?testName=audio-oscillator) 22:46:25 INFO - PROCESS | 21147 | RSS: Main: 172724224 22:46:25 INFO - PROCESS | 21147 | 22:46:27 INFO - PROCESS | 21147 | Cycle 1(1): loaded http://localhost:51836/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51836/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:46:28 INFO - PROCESS | 21147 | RSS: Main: 176955392 22:46:28 INFO - PROCESS | 21147 | 22:46:31 INFO - PROCESS | 21147 | Cycle 1(1): loaded http://localhost:51836/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51836/tests/kraken/driver.html?testName=imaging-darkroom) 22:46:31 INFO - PROCESS | 21147 | RSS: Main: 213213184 22:46:31 INFO - PROCESS | 21147 | 22:46:35 INFO - PROCESS | 21147 | Cycle 1(1): loaded http://localhost:51836/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51836/tests/kraken/driver.html?testName=imaging-desaturate) 22:46:35 INFO - PROCESS | 21147 | RSS: Main: 213872640 22:46:35 INFO - PROCESS | 21147 | 22:46:38 INFO - PROCESS | 21147 | Cycle 1(1): loaded http://localhost:51836/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51836/tests/kraken/driver.html?testName=json-parse-financial) 22:46:38 INFO - PROCESS | 21147 | RSS: Main: 213553152 22:46:38 INFO - PROCESS | 21147 | 22:46:40 INFO - PROCESS | 21147 | Cycle 1(1): loaded http://localhost:51836/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51836/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:46:41 INFO - PROCESS | 21147 | RSS: Main: 201445376 22:46:41 INFO - PROCESS | 21147 | 22:46:42 INFO - PROCESS | 21147 | Cycle 1(1): loaded http://localhost:51836/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51836/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:46:43 INFO - PROCESS | 21147 | RSS: Main: 203382784 22:46:43 INFO - PROCESS | 21147 | 22:46:45 INFO - PROCESS | 21147 | Cycle 1(1): loaded http://localhost:51836/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51836/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:46:46 INFO - PROCESS | 21147 | RSS: Main: 217923584 22:46:46 INFO - PROCESS | 21147 | 22:46:48 INFO - PROCESS | 21147 | Cycle 1(1): loaded http://localhost:51836/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51836/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:46:49 INFO - PROCESS | 21147 | RSS: Main: 222855168 22:46:49 INFO - PROCESS | 21147 | 22:46:52 INFO - PROCESS | 21147 | Cycle 1(1): loaded http://localhost:51836/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51836/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:46:52 INFO - PROCESS | 21147 | RSS: Main: 217063424 22:46:52 INFO - PROCESS | 21147 | 22:46:54 INFO - PROCESS | 21147 | Cycle 1(1): loaded http://localhost:51836/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51836/tests/kraken/driver.html?testName=ai-astar) 22:46:54 INFO - PROCESS | 21147 | RSS: Main: 280297472 22:46:54 INFO - PROCESS | 21147 | 22:46:54 INFO - PROCESS | 21147 | __start_tp_report 22:46:54 INFO - PROCESS | 21147 | _x_x_mozilla_page_load 22:46:54 INFO - PROCESS | 21147 | _x_x_mozilla_page_load_details 22:46:54 INFO - PROCESS | 21147 | |i|pagename|runs| 22:46:54 INFO - PROCESS | 21147 | |0;ai-astar;112;111;106;110;111;112;101;112;111;110 22:46:54 INFO - PROCESS | 21147 | |1;audio-beat-detection;156;126;153;186;126;150;157;127;187;126 22:46:54 INFO - PROCESS | 21147 | |2;audio-dft;161;163;164;160;158;163;161;162;160;167 22:46:54 INFO - PROCESS | 21147 | |3;audio-fft;76;72;93;117;74;73;76;121;100;73 22:46:54 INFO - PROCESS | 21147 | |4;audio-oscillator;93;92;156;92;93;92;153;93;93;155 22:46:54 INFO - PROCESS | 21147 | |5;imaging-gaussian-blur;118;118;118;116;117;117;117;117;117;118 22:46:54 INFO - PROCESS | 21147 | |6;imaging-darkroom;146;145;146;145;146;145;146;145;145;145 22:46:54 INFO - PROCESS | 21147 | |7;imaging-desaturate;95;95;96;96;96;97;95;95;95;95 22:46:54 INFO - PROCESS | 21147 | |8;json-parse-financial;57;57;57;56;57;56;56;78;54;54 22:46:54 INFO - PROCESS | 21147 | |9;json-stringify-tinderbox;66;61;61;61;62;62;61;62;62;62 22:46:54 INFO - PROCESS | 21147 | |10;stanford-crypto-aes;80;80;81;79;81;81;80;80;80;80 22:46:54 INFO - PROCESS | 21147 | |11;stanford-crypto-ccm;129;136;133;137;123;124;126;128;161;130 22:46:54 INFO - PROCESS | 21147 | |12;stanford-crypto-pbkdf2;168;163;168;165;162;163;162;167;160;162 22:46:54 INFO - PROCESS | 21147 | |13;stanford-crypto-sha256-iterative;68;68;67;68;67;66;66;66;67;67 22:46:54 INFO - PROCESS | 21147 | __end_tp_report 22:46:54 INFO - PROCESS | 21147 | __start_cc_report 22:46:54 INFO - PROCESS | 21147 | _x_x_mozilla_cycle_collect,1606 22:46:54 INFO - PROCESS | 21147 | __end_cc_report 22:46:54 INFO - PROCESS | 21147 | __startTimestamp1460612814591__endTimestamp 22:46:54 INFO - PROCESS | 21147 | 22:46:54 INFO - PROCESS | 21147 | ------- Summary: start ------- 22:46:54 INFO - PROCESS | 21147 | Number of tests: 14 22:46:54 INFO - PROCESS | 21147 | 22:46:54 INFO - PROCESS | 21147 | [#0] ai-astar Cycles:10 Average:109.60 Median:111.00 stddev:3.50 (3.2%) stddev-sans-first:3.61 22:46:54 INFO - PROCESS | 21147 | Values: 112.0 111.0 106.0 110.0 111.0 112.0 101.0 112.0 111.0 110.0 22:46:54 INFO - PROCESS | 21147 | 22:46:54 INFO - PROCESS | 21147 | [#1] audio-beat-detection Cycles:10 Average:149.40 Median:154.50 stddev:23.60 (15.3%) stddev-sans-first:24.91 22:46:54 INFO - PROCESS | 21147 | Values: 156.0 126.0 153.0 186.0 126.0 150.0 157.0 127.0 187.0 126.0 22:46:54 INFO - PROCESS | 21147 | 22:46:54 INFO - PROCESS | 21147 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.50 stddev:2.51 (1.5%) stddev-sans-first:2.65 22:46:54 INFO - PROCESS | 21147 | Values: 161.0 163.0 164.0 160.0 158.0 163.0 161.0 162.0 160.0 167.0 22:46:54 INFO - PROCESS | 21147 | 22:46:54 INFO - PROCESS | 21147 | [#3] audio-fft Cycles:10 Average:87.50 Median:73.50 stddev:19.11 (26.0%) stddev-sans-first:19.81 22:46:54 INFO - PROCESS | 21147 | Values: 76.0 72.0 93.0 117.0 74.0 73.0 76.0 121.0 100.0 73.0 22:46:54 INFO - PROCESS | 21147 | 22:46:54 INFO - PROCESS | 21147 | [#4] audio-oscillator Cycles:10 Average:111.20 Median:92.50 stddev:30.01 (32.4%) stddev-sans-first:31.10 22:46:54 INFO - PROCESS | 21147 | Values: 93.0 92.0 156.0 92.0 93.0 92.0 153.0 93.0 93.0 155.0 22:46:54 INFO - PROCESS | 21147 | 22:46:54 INFO - PROCESS | 21147 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.50 stddev:0.67 (0.6%) stddev-sans-first:0.67 22:46:54 INFO - PROCESS | 21147 | Values: 118.0 118.0 118.0 116.0 117.0 117.0 117.0 117.0 117.0 118.0 22:46:54 INFO - PROCESS | 21147 | 22:46:54 INFO - PROCESS | 21147 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 22:46:54 INFO - PROCESS | 21147 | Values: 146.0 145.0 146.0 145.0 146.0 145.0 146.0 145.0 145.0 145.0 22:46:54 INFO - PROCESS | 21147 | 22:46:54 INFO - PROCESS | 21147 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 22:46:54 INFO - PROCESS | 21147 | Values: 95.0 95.0 96.0 96.0 96.0 97.0 95.0 95.0 95.0 95.0 22:46:54 INFO - PROCESS | 21147 | 22:46:54 INFO - PROCESS | 21147 | [#8] json-parse-financial Cycles:10 Average:58.20 Median:57.00 stddev:7.05 (12.4%) stddev-sans-first:7.47 22:46:54 INFO - PROCESS | 21147 | Values: 57.0 57.0 57.0 56.0 57.0 56.0 56.0 78.0 54.0 54.0 22:46:54 INFO - PROCESS | 21147 | 22:46:54 INFO - PROCESS | 21147 | [#9] json-stringify-tinderbox Cycles:10 Average:62.00 Median:62.00 stddev:1.49 (2.4%) stddev-sans-first:0.53 22:46:54 INFO - PROCESS | 21147 | Values: 66.0 61.0 61.0 61.0 62.0 62.0 61.0 62.0 62.0 62.0 22:46:54 INFO - PROCESS | 21147 | 22:46:54 INFO - PROCESS | 21147 | [#10] stanford-crypto-aes Cycles:10 Average:80.20 Median:80.00 stddev:0.63 (0.8%) stddev-sans-first:0.67 22:46:54 INFO - PROCESS | 21147 | Values: 80.0 80.0 81.0 79.0 81.0 81.0 80.0 80.0 80.0 80.0 22:46:54 INFO - PROCESS | 21147 | 22:46:54 INFO - PROCESS | 21147 | [#11] stanford-crypto-ccm Cycles:10 Average:132.70 Median:131.50 stddev:11.00 (8.4%) stddev-sans-first:11.58 22:46:54 INFO - PROCESS | 21147 | Values: 129.0 136.0 133.0 137.0 123.0 124.0 126.0 128.0 161.0 130.0 22:46:54 INFO - PROCESS | 21147 | 22:46:54 INFO - PROCESS | 21147 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.00 Median:164.00 stddev:2.83 (1.7%) stddev-sans-first:2.60 22:46:54 INFO - PROCESS | 21147 | Values: 168.0 163.0 168.0 165.0 162.0 163.0 162.0 167.0 160.0 162.0 22:46:54 INFO - PROCESS | 21147 | 22:46:54 INFO - PROCESS | 21147 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:0.82 (1.2%) stddev-sans-first:0.78 22:46:54 INFO - PROCESS | 21147 | Values: 68.0 68.0 67.0 68.0 67.0 66.0 66.0 66.0 67.0 67.0 22:46:54 INFO - PROCESS | 21147 | -------- Summary: end -------- 22:46:54 INFO - PROCESS | 21147 | 22:46:55 INFO - TEST-INFO | 21147: exit 0 22:46:55 INFO - TEST-OK | kraken | took 60369ms 22:46:55 INFO - SUITE-END | took 1171s 22:46:55 INFO - Completed test suite (00:19:31) 22:46:55 INFO - javascript benchmark 22:46:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3073.0934374359563, 3123.968760312399, 3151.180693019814, 3157.2106973256687, 3180.348028654126, 5070.645054846163, 5173.042987047399, 5176.223566465027, 5190.8702282442955, 5224.947750522494, 5201.037808005522, 5210.478952104788, 5239.685618862871, 5247.737613119348, 5249.632525723201, 4635.281531362627, 4672.789724462399, 4697.0, 4742.620590352781, 4761.976190119045, 4640.466346370177, 4756.548127927858, 4783.593394561466, 4808.110499557575, 4815.951840481585, 4673.509281525442, 4720.64595155363, 4748.311494833264, 4751.477337492907, 4764.380630518011, 4643.721376717408, 4646.117237724855, 4655.2784318430695, 4680.7191568506, 4687.367205427292, 4607.424071991001, 4633.4208223972, 4643.558861908114, 4701.318308845232, 4778.2115950868065, 5065.4174769901565, 5081.339425874649, 5086.18621020635, 5088.1350170471105, 5115.0, 5473.589480788957, 5479.835604931858, 5495.6153069285165, 5495.807646732385, 5543.168524721284, 5380.7309634518115, 5425.674459532401, 5509.47659972302, 5515.972420137874, 5532.30846144232, 5114.718690472023, 5115.335006449175, 5123.743812809382, 5127.1796512558185, 5127.410347809975, 5553.8333849984565, 5559.0, 5560.694161821058, 5564.248826408383, 5573.470520300565, 5269.446708095671, 5300.549453296436, 5306.708131052752, 5358.3837858645975, 5362.678239305654, 5533.501984821385, 5569.66582005081, 5573.359063707644, 5575.4424557543925, 5580.386157522669, 5374.758135883894, 5511.641743286674, 5549.472800083986, 5554.1113421853115, 5602.943970560243, 5484.7531861066345, 5529.972350138223, 5560.694161821058, 5577.9442205577425, 5578.804741834017, 4197.727147735387, 4200.201961627281, 4205.894852628648, 4207.873763787091, 4242.766647834337, 3731.1045349116016, 3788.1666033472593, 3799.3351163546267, 3806.307881355081, 3828.157805282833, 5192.506711862443, 5212.035773381861, 5218.556422704112, 5228.346456692913, 5258.8159414420315, 5501.070344003632, 5501.504864562208, 5501.944980550144, 5503.174523821459, 5544.556435485151, 5054.545090941833, 5214.0, 5222.582193424517, 5227.529522342931, 5310.522053015247, 4750.144973904661, 4751.1447939370555, 4766.618670506351, 4767.833125840579, 4807.254875494234, 5643.294588176478, 5644.125160600113, 5681.488666019995, 5684.772609095672, 5693.743781529841, 5342.0, 5534.695591742412, 5545.972270138624, 5639.407862174577, 5661.716914154358, 5649.406812284651, 5667.03660377745, 5676.262085928803, 5685.232493613309, 5688.829335119953, 5396.757145928521, 5417.6478528895495, 5437.972810135924, 5450.727463626724, 5506.03644362243, 5334.706591137525, 5518.365387980273, 5582.358028826737, 5594.86012849682, 5603.35561410443, 5356.625036247426, 5379.1662292344745, 5381.381141168816, 5383.892322153613, 5384.946150538444, 5266.236395722675, 5299.2316114164005, 5358.517733404013, 5372.1941708744, 5402.891942161214, 5193.169092945111, 5225.712585807817, 5251.317328747391, 5269.130593452038, 5298.046351656739, 5471.8084867029465, 5513.917291240715, 5520.834374968757, 5520.889582208253, 5520.972395137998, 5085.415177254663, 5277.868053298698, 5380.569554435714, 5400.540954018796, 5446.046941785251], "value": 5089.291697365235, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [609.3906093906094, 652.5693042591889, 656.4977791989132, 665.6272487407051, 668.3316683316681, 29893.0, 30279.394412111746, 30286.242843928914, 30630.0, 35346.8232658837, 38501.42247866284, 39217.80391098041, 39222.80388598053, 39265.60734392655, 39290.410643840296, 8470.195331443503, 8680.34897382699, 8681.56592170389, 8683.0, 8685.218330350268, 8386.245237928586, 8475.660973561051, 8497.830043399128, 8500.192481714228, 8501.532415717164, 8509.787255318635, 8804.987426445976, 8809.735707928772, 8814.294856411503, 8815.823683526325, 8678.956605216934, 8681.392302538825, 8682.565871706389, 8714.694985675502, 8752.256058235058, 8752.081031491665, 8854.468731876044, 8863.955680221557, 8876.934767827903, 8895.110488951117, 40136.59863401387, 40644.0, 40679.593204067874, 40698.0, 40743.18513629711, 3446.8104254266004, 3574.8391322390553, 3576.8926932191816, 3580.0, 3644.0343309022865, 29929.850350748107, 30197.547036794465, 30241.69758302433, 30548.38903221923, 31302.21744456384, 4210.136921930997, 4242.3788480263465, 4257.8296868125235, 4289.871303860889, 4314.439122914033, 268065.0, 272172.0, 272629.0, 272730.999999998, 272992.0, 56422.15366769502, 56701.716491417275, 56996.430035699945, 56997.0, 57032.714836426385, 57447.0, 63967.680161598895, 65821.0, 65948.67025664842, 66004.0, 16792.580185495215, 16869.409570664968, 16882.15589220534, 16950.915245423694, 16957.49127526176, 11769.293842369485, 11899.821502677467, 11921.34432606215, 11961.162718609788, 11992.340421276913, 18336.81663183378, 18897.905510472636, 18982.81017189838, 19134.425967221006, 19147.8085219146, 6781.525293229427, 6809.795706128824, 6982.301769822977, 6990.679427272005, 7025.665123626597, 933.8365785987424, 985.522021819417, 1050.9894901051046, 1070.8035475929173, 1087.9945600272106, 31869.68130318667, 31896.681033189834, 32207.838960805515, 32657.0, 32744.181395465304, 1113.4432783608195, 1134.4724703012973, 1174.1780753472603, 1213.8179273109104, 1290.9677258068436, 16693.0, 17189.31242750276, 17212.655746884993, 17248.310067597155, 17273.91363043177, 474999.0, 703281.0, 719047.0, 720270.0, 722585.0, 55980.72009640007, 56631.43368566262, 56936.86126277451, 57117.0, 57167.42832571704, 1099.4612639806596, 1186.1815347410432, 1350.628577141294, 1368.9657758556116, 1379.7309524642799, 29407.26481837971, 32024.35951281008, 32100.839495803306, 32268.677313227505, 32630.673693263714, 44402.333964989906, 44868.55131448644, 45373.31940020836, 45470.77264613656, 45522.54477455183, 282356.0, 284399.0, 285601.85995350283, 286800.0, 286898.0, 25118.12086576961, 25421.237362879143, 25689.486210276064, 25862.741372586785, 27896.0, 43569.346459802495, 43609.56390436055, 43888.561114389726, 43940.0, 44712.77643611761, 35594.64405355913, 36214.0, 36601.81699091488, 36693.816530917175, 37154.628453715115, 37592.62407375891, 37840.243195135394, 37874.431883522324, 38047.0, 38192.23615527618, 38065.4290185653, 38583.614163858, 38755.80622096871, 39195.41206881842, 39550.0, 32445.35109297848, 33210.83394583012, 33477.83261083679, 34074.829625852704, 34147.82926085453, 26765.33086672771, 26823.731762682124, 27095.322616934733, 27164.592531111655, 27758.583621245292], "value": 19141.720927852555, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.4536902966817, 387.89526827756504, 389.7992533845069, 399.6103798796174, 402.07923854373485, 14450.13299202046, 17865.7320140198, 18243.087845607715, 18641.16114774835, 18785.060746962667, 17675.381361652344, 17764.0, 18338.358157464492, 18864.622707545874, 18941.14764835582, 5547.55619550436, 5621.943780562183, 5674.148877668342, 5704.8859022819515, 5713.571482138836, 4100.692448066392, 5576.247206627094, 5588.022096133181, 5619.6066275360745, 5869.442402971732, 6117.0, 6134.570580059375, 6135.263768347782, 6136.171616831737, 6137.079438084278, 6037.7584896604085, 6100.969495152518, 6113.388661133896, 6115.541334399938, 6123.5407344448895, 5370.9731451342495, 5555.638883472602, 5561.77752889884, 5566.997940370732, 5589.301337332833, 22097.337079887628, 22317.888410558007, 23096.53806923869, 23151.0, 23154.65268020981, 2527.3428908483743, 2540.453802432486, 2612.9477410451686, 2906.968026350636, 3121.7034381733697, 9246.676366327214, 14013.229272390014, 14089.225092619901, 14211.78682319766, 14534.418623255056, 1930.9131089101024, 1961.2743284984647, 1983.6032793441225, 2003.8396928245852, 2046.467918341227, 79462.0, 83608.99999999939, 83710.0, 85026.0, 85278.57360713219, 10671.306365086244, 10673.199510036779, 10701.518431670593, 10804.621838235624, 10973.50619222137, 12435.129540932228, 13332.533361332307, 15101.773473397909, 15106.924465377602, 15112.0, 6172.197614310111, 6235.127082208494, 7229.710811567584, 7891.960540197262, 7977.401694872908, 7313.707451701979, 7468.551886886696, 7528.360089392463, 7562.016937798051, 7702.9229707703325, 4525.389072475174, 4550.954490455053, 4655.162070827216, 4714.0, 4818.373986177542, 1853.2309091727052, 1893.3751861885544, 1928.2865339824355, 1966.4788830959808, 2002.8898410587558, 902.7562558109405, 932.2821427500786, 940.3652534539159, 1094.7372630568766, 1103.0844399148687, 19005.429837104908, 19141.330053448062, 19380.515487112934, 19450.0, 19535.0, 915.9954200228956, 921.4655499810228, 922.280621115531, 1027.5530144387214, 1031.8555402243692, 10335.586576537005, 10535.894641053492, 10566.404025296717, 10914.0, 11135.164862635334, 442597.0, 457185.0, 464731.0, 480048.0, 481477.0, 91660.0, 92051.53974230085, 92111.0, 92384.53807730919, 92600.53699731592, 946.2382781860669, 969.4231932000589, 1054.847047178155, 1073.8926107389198, 1081.0756802933379, 17229.39697110595, 17234.482965511055, 17390.0, 17435.389761358292, 17507.0, 25135.69979107742, 34170.31659366848, 38720.41919371268, 39394.40908386434, 39877.20245595014, 49265.75367123285, 49662.25506617331, 49771.50228497814, 49974.750126249135, 50730.74634626951, 7458.993035940079, 7765.7670269892, 7947.403944704055, 8258.504489730636, 8401.411901166859, 9359.859602105838, 12592.0, 13428.39572219233, 13442.327883605585, 13490.190588564717, 11346.773064538498, 11534.94232528832, 11562.0, 11641.0, 11901.82147267809, 11081.889181108085, 11742.412879355827, 11753.823692644788, 11968.880311197125, 11975.880241197476, 11632.360220187971, 11756.647300580997, 11867.490353665551, 11924.701882453008, 11999.64001079969, 8074.071481779671, 8163.877541836759, 8280.751577452686, 8513.489190648581, 8546.957265213883, 10142.898571014195, 11982.700432489257, 12121.575744848888, 12214.26714397139, 12230.755384892074], "value": 9097.595476343025, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1253.7367152897891, 1287.3756228229313, 1333.3466601365335, 1383.391307824557, 1480.0453707358754, 7681.116671582763, 8016.879746803788, 8021.558814265206, 8029.036515618127, 8040.557769322685, 7765.18465561115, 7919.920800791991, 7921.207879212076, 7929.326007289373, 7934.1272460029495, 2005.5788284460282, 2287.4853158039473, 2306.6770652108676, 2329.8369114161933, 2377.738448770634, 2342.3441436397834, 2365.1603680693365, 2366.4320563064825, 2367.1951536477595, 2368.0291080656934, 2294.5181511882442, 2344.742078371378, 2346.190564255338, 2346.2374728213313, 2349.107339211106, 2024.8177664010236, 2234.519578290667, 2299.850509716863, 2301.8503797253125, 2304.68886700295, 2217.8558393704357, 2220.11195521791, 2227.7438094619, 2227.9108835646553, 2260.0168926517017, 7969.163237859999, 8039.397045221632, 8155.836883262361, 8165.101838797727, 8244.216799404046, 4968.279599458058, 5111.539961403454, 5140.997505486432, 5154.587632989352, 5160.071187186305, 3151.6533181350032, 3179.761517886168, 3221.919452013695, 3245.2860370718404, 3248.2691394436297, 1077.3374374759467, 1102.9944850275776, 1103.0623969625833, 1128.368113856243, 1131.185546406586, 11087.2238943274, 11098.167637427225, 11106.389148596823, 11111.499982500725, 11127.66617001483, 4400.273954797422, 4433.534478879736, 4524.9095018100115, 4612.07758448305, 4616.930746038812, 9054.094590541024, 9055.818883622422, 9064.184223419923, 9073.546322683971, 9084.18242358191, 4633.72197668141, 5070.366204224472, 5093.8726531837, 5116.565091967224, 5129.461406552333, 4669.836555720533, 4750.809967601326, 4754.0, 4757.881052973703, 4797.64017698674, 3801.3917773156163, 3830.19565891166, 3922.0783115967724, 3930.449737036817, 3947.743396679207, 1266.0820904843915, 1283.076185146693, 1284.3064745037761, 1287.5493577248076, 1307.1634154141357, 949.4493193947494, 966.8211380894558, 978.7406337320616, 983.1852412639058, 987.9061489158519, 5531.25328080712, 5755.568332375088, 5786.833479894469, 5802.390748971382, 5823.184754134425, 415.83158820677676, 429.19097501210445, 432.12710325143036, 439.973601583906, 446.32827594470115, 4096.91806163875, 4154.459920210414, 4166.500019997619, 4173.728707633994, 4177.248095342868, 10069.395836249849, 10479.266451348485, 10553.63062292816, 10558.947205263925, 10572.788544229226, 10250.128739057114, 10371.585136594602, 10406.531706073245, 10414.843777343345, 10417.062464378243, 7482.176960534228, 7826.530408175528, 7849.9215007850335, 7939.563324017119, 7961.840763184704, 5658.151277308437, 5714.285714285715, 5729.770809167587, 5737.91393129095, 5847.649141051551, 9191.94292656353, 9284.814303714023, 9407.85888211691, 9412.905870941204, 9524.190443812353, 9457.952710236405, 9568.665096721581, 9579.329446938647, 9629.518524073908, 9707.417554946725, 6826.488013398915, 7054.964725176341, 7225.277472252733, 7391.2239214881665, 7695.076590809139, 8171.959140204499, 8178.550179740171, 8245.0, 8253.215944485264, 8264.710735124241, 6933.583984960918, 7142.0, 7168.89246661311, 7207.243239459781, 7340.302671246223, 7418.035655364768, 7430.554166750012, 7474.2525747424825, 7504.0, 7550.962245188739, 6741.089952856301, 6778.728850846108, 6816.591004539743, 6818.249992500921, 6829.556078854858, 5005.299258103795, 5023.447420783637, 5025.47232540578, 5032.245163225399, 5039.773210205476, 5109.1059064662795, 5141.562967147835, 5172.922406163835, 5189.221616757365, 5313.1764576490705], "value": 4358.670857573499, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.39479002919376, 320.7946913975055, 328.7435800075942, 335.94624860022395, 341.9760616756827, 5389.622726409153, 5555.805546805863, 5609.074502707053, 5665.3768085510565, 5687.943120568798, 5590.217369568264, 5614.259579530339, 5627.099664053742, 5647.068233741438, 5668.178114173443, 4351.151525452538, 4351.195028919644, 4357.411749413836, 4357.869263922087, 4378.540253273408, 4218.957810421903, 4334.284843000901, 4351.0, 4351.6953813233085, 4378.233809083414, 4304.483461984566, 4309.806058727349, 4310.310350343945, 4314.503832059307, 4314.84898028569, 4301.698881078326, 4322.935155972663, 4324.729517003567, 4340.717853339523, 4348.695591308594, 3712.6472985066644, 3742.502365067361, 3792.6396992285963, 3799.1072098056934, 3805.2389522095414, 5383.811566595189, 5419.132938729785, 5423.159410291411, 5432.049391356497, 5443.421407791775, 4893.75531223441, 4923.089228492705, 4937.925931111036, 4951.900961980777, 4993.176125939216, 5601.383847776741, 5809.912851307234, 5864.091065884794, 5899.852503687399, 5909.099994003936, 4141.751494910285, 4177.707560470738, 4180.435641188431, 4181.581841815824, 4186.120914607905, 6093.786717464912, 6133.1106989486725, 6142.8771424571705, 6144.41628045335, 6151.231096112986, 4177.394277829698, 4256.403848556791, 4273.572642735764, 4275.251830929575, 4293.91412171761, 4309.569043095728, 4322.502912165079, 4327.437433133672, 4348.826046958149, 4350.73895566267, 4951.06908305761, 4956.231784073474, 4968.72672003036, 4970.403551573834, 4973.5523802857915, 5722.227499287543, 5890.8821823563285, 5891.3814049525035, 5930.22907022093, 5943.613665111754, 1459.8540145985316, 1468.544751127154, 1474.800901878254, 1474.837767845536, 1481.8147731533559, 973.3429934793986, 977.3940157102642, 990.1633120013577, 990.5641517732175, 1026.384169498295, 5742.913856292159, 5749.338826034976, 5754.539636829044, 5763.4812866842185, 5764.5676574257095, 5978.0, 5978.581499295007, 5996.430339117776, 6018.337982821886, 6033.728482218311, 5503.532199762985, 5670.432956704297, 5688.374278829326, 5689.175069614883, 5697.088465845528, 3202.647708752035, 3207.5028370602595, 3233.0, 3238.757093218018, 3262.8368581570826, 6101.145839582462, 6221.8133455995485, 6285.748570057147, 6287.622742635456, 6307.24313082433, 6209.192804935329, 6227.439530442282, 6231.189945307081, 6248.937510624926, 6265.498760099181, 6259.18630578031, 6270.435660790551, 6275.341089185661, 6295.98528470885, 6304.148939893055, 5792.536597072309, 6016.187814645142, 6018.849528761816, 6022.638641681513, 6040.426159514839, 5938.079597662369, 5968.343482217039, 6012.128241405059, 6031.0, 6037.547183961133, 6053.364396738279, 6081.756729730938, 6287.245530536182, 6293.0, 6304.873902522016, 4161.8959526012095, 4288.614024737789, 4294.398784170281, 4298.806553705028, 4302.268614335508, 6048.969755151196, 6076.544259180668, 6100.420460056288, 6102.877942441215, 6140.355262697352, 5815.33123690764, 5914.142449344907, 5948.553858460719, 5973.820785376446, 5977.0, 5860.15027820955, 5916.970415147896, 5924.62296490996, 5931.377205393372, 5963.2844058713235, 5835.0, 5847.239858818497, 5850.151727999331, 5868.354481007001, 5869.882602347844, 5745.798897038583, 6018.8194354169445, 6030.4572588467245, 6044.607100538451, 6048.274207095177, 5848.298204215522, 5855.151003104611, 5884.146493854593, 5892.292924849045, 5927.644341339534], "value": 4478.716904506322, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [728.5519405565578, 796.8246985663154, 807.6527093349857, 849.7153453593046, 852.2585350744849, 14313.642158946019, 14522.927385363058, 14548.92725536371, 14603.12381257124, 14610.415583376665, 12585.307808070553, 12687.365631718423, 12688.555900543482, 12695.428705708242, 12703.301318427482, 647.0908373734886, 780.5394817057935, 781.88271759236, 801.3869389916689, 804.0672819529348, 780.637003793236, 787.6652422720349, 787.8621241282781, 789.1753117991684, 793.0602236349915, 841.3899922556159, 841.970531031414, 842.3008902610849, 844.0799528513919, 850.3579797253066, 682.9931700682979, 829.4401279136558, 848.753861380199, 851.4891065360796, 851.7231899632583, 623.5510432488646, 624.5347216323868, 624.6221036273034, 624.8156793745856, 624.8750249949983, 13149.605511834565, 13162.14446061003, 13171.73656526864, 13214.339283035906, 13222.206667599974, 13131.34343282832, 13213.075084744072, 13223.140495867738, 13578.117422367613, 13820.861791382058, 10943.179261555415, 10985.176111791647, 11063.170262230366, 11135.0, 11213.102951763922, 3712.109093817491, 3755.47423360727, 3759.7368184227116, 3777.9433308500393, 3800.429935509668, 55600.0, 57659.71170144164, 57693.423065769646, 57722.0, 57985.0, 10364.844527332096, 10699.83950240747, 10726.356418614909, 10746.73133171677, 11024.779504409868, 18464.35374761877, 18889.0, 18910.62178756417, 18922.62154756897, 18929.621407571773, 8130.0, 8169.346452283803, 8229.670813167406, 8288.088310285864, 8342.916570834213, 4595.035042641083, 4666.87994881226, 4680.180968330528, 4731.834385796549, 4739.431268247763, 3202.1834432219634, 3309.2223327518013, 3309.8014119152444, 3311.8675252990092, 3325.6840600142946, 593.4955288005161, 611.8225714542822, 616.2743150884985, 653.8430776613578, 661.5567569728294, 616.6926116632767, 664.9202095748444, 667.893137098062, 674.2078058281597, 679.6907407129744, 8717.607707653044, 8914.193810994037, 9278.768030799149, 9448.811023779623, 9474.573644186028, 577.6245440463732, 664.9202095748444, 667.9365460281266, 685.3454950522339, 691.260212923991, 4342.217330019452, 4356.172327257811, 4376.693631445768, 4451.087527056946, 4461.330800379904, 52469.0, 54137.72931135398, 69806.30193697997, 69924.0, 70025.64987175031, 51545.22682159771, 51849.48150518522, 52849.207261891104, 53185.46814531805, 53589.196162057604, 44530.777346112416, 47985.28022079672, 48349.75825120852, 48530.0, 49041.754791225816, 9113.544322783702, 9129.132732390412, 9157.908420915706, 9180.17378435944, 9367.484788336707, 32883.177920552174, 33111.33777324488, 33506.0, 33733.83133084319, 33803.492947605315, 42333.36499952441, 44999.100018000114, 46181.30728039015, 46454.53545464502, 46753.29870051884, 10386.37681739068, 10473.790524189626, 11257.549698011988, 11591.6522504325, 11826.76346473083, 13191.274479903697, 13447.663808404868, 13477.595672129852, 13752.518661847187, 14269.42922283097, 12467.812982805084, 12766.297853617769, 12857.164284321489, 12956.222626642431, 13030.348482576022, 12088.15382923187, 12199.756004879675, 12423.503059877865, 12432.12975091735, 12442.129050966345, 12572.182808117443, 12626.242425454502, 12712.74574508523, 12889.09776315649, 13334.533291334757, 10653.307535010199, 10805.405702686428, 10843.295185812896, 10898.40058796742, 11082.667519974413, 11118.38848863288, 11150.219484635998, 11208.943955280172, 11213.215074944676, 11215.60745373908], "value": 6630.235770373999, "unit": "score"}], "name": "dromaeo_css", "value": 6970.6660010377955, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 111.0, 106.0, 110.0, 111.0, 112.0, 101.0, 112.0, 111.0, 110.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 126.0, 153.0, 186.0, 126.0, 150.0, 157.0, 127.0, 187.0, 126.0], "value": 149.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 164.0, 160.0, 158.0, 163.0, 161.0, 162.0, 160.0, 167.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 72.0, 93.0, 117.0, 74.0, 73.0, 76.0, 121.0, 100.0, 73.0], "value": 87.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 156.0, 92.0, 93.0, 92.0, 153.0, 93.0, 93.0, 155.0], "value": 111.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 145.0, 146.0, 145.0, 146.0, 145.0, 145.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 96.0, 97.0, 95.0, 95.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 57.0, 56.0, 57.0, 56.0, 56.0, 78.0, 54.0, 54.0], "value": 58.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 61.0, 61.0, 61.0, 62.0, 62.0, 61.0, 62.0, 62.0, 62.0], "value": 62.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 81.0, 79.0, 81.0, 81.0, 80.0, 80.0, 80.0, 80.0], "value": 80.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 136.0, 133.0, 137.0, 123.0, 124.0, 126.0, 128.0, 161.0, 130.0], "value": 132.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 163.0, 168.0, 165.0, 162.0, 163.0, 162.0, 167.0, 160.0, 162.0], "value": 164.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 67.0, 68.0, 67.0, 66.0, 66.0, 66.0, 67.0, 67.0], "value": 67.0, "unit": "score"}], "name": "kraken", "value": 1541.9, "alertThreshold": 2.0}]} 22:46:55 INFO - Return code: 0 22:46:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 22:46:55 ERROR - # TBPL SUCCESS # 22:46:55 INFO - Running post-action listener: _resource_record_post_action 22:46:55 INFO - Running post-run listener: _resource_record_post_run 22:46:56 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 538628096; Read time: 12; Write time: 460020 22:46:56 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 243642368; Read time: 0; Write time: 244068 22:46:56 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 294805504; Read time: 12; Write time: 215924 22:46:56 INFO - Running post-run listener: _upload_blobber_files 22:46:56 INFO - Blob upload gear active. 22:46:56 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 22:46:56 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 22:46:56 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', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 22:46:56 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 Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 22:46:57 INFO - (blobuploader) - INFO - Open directory for files ... 22:46:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 22:46:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:46:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:46:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:46:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:46:58 INFO - (blobuploader) - INFO - Done attempting. 22:46:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:46:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:46:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:46:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:46:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:46:59 INFO - (blobuploader) - INFO - Done attempting. 22:46:59 INFO - (blobuploader) - INFO - Iteration through files over. 22:46:59 INFO - Return code: 0 22:46:59 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 22:46:59 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 22:46:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5319b31a24c00f6eebf6ad85bfa62a140d25dc7731bc4154557d7ebffdf9ef32c0845782a13ef2ec4180a71230441491591346d57503dd5704caaf201e2e6b18", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8530e8a9b3bf1d5dc4c58b40441f0b228c5db073ca64c7de0f11dceb8a239f89028f93d88b9e98c17cc72cb28e6dba8d36783ccab8d1a2db86197dc38436f3e4"} 22:46:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 22:46:59 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 22:46:59 INFO - Contents: 22:46:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5319b31a24c00f6eebf6ad85bfa62a140d25dc7731bc4154557d7ebffdf9ef32c0845782a13ef2ec4180a71230441491591346d57503dd5704caaf201e2e6b18", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8530e8a9b3bf1d5dc4c58b40441f0b228c5db073ca64c7de0f11dceb8a239f89028f93d88b9e98c17cc72cb28e6dba8d36783ccab8d1a2db86197dc38436f3e4"} 22:46:59 INFO - Running post-run listener: copy_logs_to_upload_dir 22:46:59 INFO - Copying logs to upload dir... 22:46:59 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 22:46:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.822020 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-04-13 22:46:59.431371) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-13 22:46:59.434551) ========= 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=1f5564757af27664ca02d71f000001b0-1460610782.968931-43161327 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5319b31a24c00f6eebf6ad85bfa62a140d25dc7731bc4154557d7ebffdf9ef32c0845782a13ef2ec4180a71230441491591346d57503dd5704caaf201e2e6b18", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8530e8a9b3bf1d5dc4c58b40441f0b228c5db073ca64c7de0f11dceb8a239f89028f93d88b9e98c17cc72cb28e6dba8d36783ccab8d1a2db86197dc38436f3e4"} build_url:https://queue.taskcluster.net/v1/task/SjZF20saQ5-MMJUDtEN1cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011412 build_url: 'https://queue.taskcluster.net/v1/task/SjZF20saQ5-MMJUDtEN1cg/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/Firefox/sha512/5319b31a24c00f6eebf6ad85bfa62a140d25dc7731bc4154557d7ebffdf9ef32c0845782a13ef2ec4180a71230441491591346d57503dd5704caaf201e2e6b18", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8530e8a9b3bf1d5dc4c58b40441f0b228c5db073ca64c7de0f11dceb8a239f89028f93d88b9e98c17cc72cb28e6dba8d36783ccab8d1a2db86197dc38436f3e4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-13 22:46:59.464213) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 22:46:59.464924) ========= 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=1f5564757af27664ca02d71f000001b0-1460610782.968931-43161327 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004499 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 22:46:59.550703) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-13 22:46:59.551532) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-13 22:46:59.552364) ========= ========= Total master_lag: 0.29 =========