builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-048 starttime: 1457444610.3 results: success (0) buildid: 20160308030418 builduid: 52f869aa1dd9435989dd476b4b9f0811 revision: 05c087337043dd8e71cc27bdb5b9d55fd00aaa26 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-08 05:43:30.304068) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-08 05:43:30.304523) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-08 05:43:30.304862) ========= 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=fa44defc139c4ba8574fe040000001db-1457443761.898035-2022830480 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006328 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-08 05:43:30.330123) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-08 05:43:30.330429) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-08 05:43:30.363437) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 05:43:30.363738) ========= 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=fa44defc139c4ba8574fe040000001db-1457443761.898035-2022830480 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004602 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 05:43:30.420325) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-08 05:43:30.420653) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-08 05:43:30.421078) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 05:43:30.421405) ========= 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=fa44defc139c4ba8574fe040000001db-1457443761.898035-2022830480 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-08 05:43:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-03-08 05:43:31 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.168263 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 05:43:30.611480) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 05:43:30.611823) ========= 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=fa44defc139c4ba8574fe040000001db-1457443761.898035-2022830480 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015593 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 05:43:30.665975) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 05:43:30.666320) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 05c087337043dd8e71cc27bdb5b9d55fd00aaa26 --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 05c087337043dd8e71cc27bdb5b9d55fd00aaa26 --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=fa44defc139c4ba8574fe040000001db-1457443761.898035-2022830480 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-08 05:43:31,784 truncating revision to first 12 chars 2016-03-08 05:43:31,784 Setting DEBUG logging. 2016-03-08 05:43:31,784 attempt 1/10 2016-03-08 05:43:31,784 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/05c087337043?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-08 05:43:32,047 unpacking tar archive at: mozilla-central-05c087337043/testing/mozharness/ program finished with exit code 0 elapsedTime=0.572545 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 05:43:31.252191) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-08 05:43:31.253017) ========= echo 05c087337043dd8e71cc27bdb5b9d55fd00aaa26 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'05c087337043dd8e71cc27bdb5b9d55fd00aaa26'] 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=fa44defc139c4ba8574fe040000001db-1457443761.898035-2022830480 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05c087337043dd8e71cc27bdb5b9d55fd00aaa26 program finished with exit code 0 elapsedTime=0.003603 script_repo_revision: '05c087337043dd8e71cc27bdb5b9d55fd00aaa26' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-08 05:43:31.303461) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-08 05:43:31.303932) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-08 05:43:31.315052) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-03-08 05:43:31.315359) ========= /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=fa44defc139c4ba8574fe040000001db-1457443761.898035-2022830480 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:43:32 INFO - MultiFileLogger online at 20160308 05:43:32 in /builds/slave/test-pgo 05:43:32 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 05:43:32 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:43:32 INFO - {'append_to_log': False, 05:43:32 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:43:32 INFO - 'blob_upload_branch': 'Firefox', 05:43:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:43:32 INFO - 'branch': 'Firefox', 05:43:32 INFO - 'buildbot_json_path': 'buildprops.json', 05:43:32 INFO - 'config_files': ('talos/linux_config.py',), 05:43:32 INFO - 'default_actions': ('clobber', 05:43:32 INFO - 'read-buildbot-config', 05:43:32 INFO - 'download-and-extract', 05:43:32 INFO - 'populate-webroot', 05:43:32 INFO - 'create-virtualenv', 05:43:32 INFO - 'install', 05:43:32 INFO - 'run-tests'), 05:43:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:43:32 INFO - 'download_minidump_stackwalk': True, 05:43:32 INFO - 'download_symbols': 'ondemand', 05:43:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:43:32 INFO - 'tooltool.py': '/tools/tooltool.py', 05:43:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:43:32 INFO - '/tools/misc-python/virtualenv.py')}, 05:43:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:43:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:43:32 INFO - 'installer_path': 'installer.exe', 05:43:32 INFO - 'log_level': 'info', 05:43:32 INFO - 'log_name': 'talos', 05:43:32 INFO - 'log_to_console': True, 05:43:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:43:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:43:32 INFO - 'opt_config_files': (), 05:43:32 INFO - 'pip_index': False, 05:43:32 INFO - 'sps_profile': False, 05:43:32 INFO - 'sps_profile_interval': 0, 05:43:32 INFO - 'suite': 'dromaeojs', 05:43:32 INFO - 'system_bits': '32', 05:43:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:43:32 INFO - 'title': 'talos-linux64-ix-048', 05:43:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:43:32 INFO - 'use_talos_json': True, 05:43:32 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:43:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:43:32 INFO - 'work_dir': 'build'} 05:43:32 INFO - ##### 05:43:32 INFO - ##### Running clobber step. 05:43:32 INFO - ##### 05:43:32 INFO - Running pre-action listener: _resource_record_pre_action 05:43:32 INFO - Running main action method: clobber 05:43:32 INFO - rmtree: /builds/slave/test-pgo/build 05:43:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:43:33 INFO - Running post-action listener: _resource_record_post_action 05:43:33 INFO - ##### 05:43:33 INFO - ##### Running read-buildbot-config step. 05:43:33 INFO - ##### 05:43:33 INFO - Running pre-action listener: _resource_record_pre_action 05:43:33 INFO - Running main action method: read_buildbot_config 05:43:33 INFO - Using buildbot properties: 05:43:33 INFO - { 05:43:33 INFO - "project": "", 05:43:33 INFO - "product": "firefox", 05:43:33 INFO - "script_repo_revision": "production", 05:43:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:43:33 INFO - "repository": "", 05:43:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:43:33 INFO - "buildid": "20160308030418", 05:43:33 INFO - "stage_platform": "linux64-pgo", 05:43:33 INFO - "basedir": "/builds/slave/test-pgo", 05:43:33 INFO - "nightly_build": "True", 05:43:33 INFO - "buildnumber": 705, 05:43:33 INFO - "slavename": "talos-linux64-ix-048", 05:43:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:43:33 INFO - "platform": "ubuntu64_hw", 05:43:33 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:43:33 INFO - "branch": "mozilla-central", 05:43:33 INFO - "repo_path": "mozilla-central", 05:43:33 INFO - "revision": "05c087337043dd8e71cc27bdb5b9d55fd00aaa26", 05:43:33 INFO - "pgo_build": "True", 05:43:33 INFO - "builduid": "52f869aa1dd9435989dd476b4b9f0811", 05:43:33 INFO - "slavebuilddir": "test" 05:43:33 INFO - } 05:43:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/bJRKDbyBRE2GQA4HmJVgQg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 05:43:33 INFO - Running post-action listener: _resource_record_post_action 05:43:33 INFO - ##### 05:43:33 INFO - ##### Running download-and-extract step. 05:43:33 INFO - ##### 05:43:33 INFO - Running pre-action listener: _resource_record_pre_action 05:43:33 INFO - Running main action method: download_and_extract 05:43:33 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:43:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:33 INFO - https://queue.taskcluster.net/v1/task/bJRKDbyBRE2GQA4HmJVgQg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:43:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJRKDbyBRE2GQA4HmJVgQg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:43:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJRKDbyBRE2GQA4HmJVgQg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:43:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJRKDbyBRE2GQA4HmJVgQg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:43:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJRKDbyBRE2GQA4HmJVgQg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:43:35 INFO - Downloaded 1448 bytes. 05:43:35 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:43:35 INFO - Using the following test package requirements: 05:43:35 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:43:35 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:35 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:43:35 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:35 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:43:35 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:35 INFO - u'jsshell-linux-x86_64.zip'], 05:43:35 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:35 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:43:35 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:43:35 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:35 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:43:35 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:35 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:43:35 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:35 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:43:35 INFO - u'webapprt': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:43:35 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:35 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:43:35 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:43:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:35 INFO - https://queue.taskcluster.net/v1/task/bJRKDbyBRE2GQA4HmJVgQg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:43:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJRKDbyBRE2GQA4HmJVgQg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:43:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJRKDbyBRE2GQA4HmJVgQg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:43:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJRKDbyBRE2GQA4HmJVgQg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:43:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJRKDbyBRE2GQA4HmJVgQg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:43:36 INFO - Downloaded 23405956 bytes. 05:43:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:43:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 05:43:37 INFO - Return code: 0 05:43:37 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:43:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:37 INFO - https://queue.taskcluster.net/v1/task/bJRKDbyBRE2GQA4HmJVgQg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:43:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJRKDbyBRE2GQA4HmJVgQg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:43:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJRKDbyBRE2GQA4HmJVgQg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:43:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJRKDbyBRE2GQA4HmJVgQg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:43:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJRKDbyBRE2GQA4HmJVgQg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:43:42 INFO - Downloaded 23405956 bytes. 05:43:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:43:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 05:43:43 INFO - Return code: 0 05:43:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:43 INFO - https://queue.taskcluster.net/v1/task/bJRKDbyBRE2GQA4HmJVgQg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:43:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJRKDbyBRE2GQA4HmJVgQg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:43:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJRKDbyBRE2GQA4HmJVgQg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:43:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJRKDbyBRE2GQA4HmJVgQg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:43:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJRKDbyBRE2GQA4HmJVgQg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:43:44 INFO - Downloaded 10845161 bytes. 05:43:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:43:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 05:43:45 INFO - Return code: 0 05:43:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:45 INFO - https://queue.taskcluster.net/v1/task/bJRKDbyBRE2GQA4HmJVgQg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:43:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJRKDbyBRE2GQA4HmJVgQg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:43:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJRKDbyBRE2GQA4HmJVgQg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:43:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJRKDbyBRE2GQA4HmJVgQg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:43:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJRKDbyBRE2GQA4HmJVgQg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:43:46 INFO - Downloaded 56184920 bytes. 05:43:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bJRKDbyBRE2GQA4HmJVgQg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:43:46 INFO - mkdir: /builds/slave/test-pgo/properties 05:43:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:43:46 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:43:46 INFO - Contents: 05:43:46 INFO - build_url:https://queue.taskcluster.net/v1/task/bJRKDbyBRE2GQA4HmJVgQg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:43:47 INFO - Running post-action listener: _resource_record_post_action 05:43:47 INFO - Running post-action listener: set_extra_try_arguments 05:43:47 INFO - ##### 05:43:47 INFO - ##### Running populate-webroot step. 05:43:47 INFO - ##### 05:43:47 INFO - Running pre-action listener: _resource_record_pre_action 05:43:47 INFO - Running main action method: populate_webroot 05:43:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:43:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:43:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:43:47 INFO - '--tppagecycles', 05:43:47 INFO - '7'], 05:43:47 INFO - 'tests': ['tsvgm']}}, 05:43:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:43:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:43:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:43:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:43:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:43:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:43:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:43:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:47 INFO - 'talos_options': ['--e10s'], 05:43:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:43:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:47 INFO - 'tests': ['damp', 'tps']}, 05:43:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:47 INFO - 'talos_options': ['--e10s'], 05:43:47 INFO - 'tests': ['damp', 'tps']}, 05:43:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:43:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:43:47 INFO - 'other': {'tests': ['a11yr', 05:43:47 INFO - 'ts_paint', 05:43:47 INFO - 'tpaint', 05:43:47 INFO - 'sessionrestore', 05:43:47 INFO - 'sessionrestore_no_auto_restore', 05:43:47 INFO - 'tabpaint']}, 05:43:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:43:47 INFO - 'tests': ['a11yr', 05:43:47 INFO - 'ts_paint', 05:43:47 INFO - 'tpaint', 05:43:47 INFO - 'sessionrestore', 05:43:47 INFO - 'sessionrestore_no_auto_restore', 05:43:47 INFO - 'tabpaint']}, 05:43:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:43:47 INFO - 'tests': ['a11yr', 05:43:47 INFO - 'ts_paint', 05:43:47 INFO - 'tpaint', 05:43:47 INFO - 'sessionrestore', 05:43:47 INFO - 'sessionrestore_no_auto_restore', 05:43:47 INFO - 'tabpaint']}, 05:43:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:43:47 INFO - 'tests': ['a11yr', 05:43:47 INFO - 'ts_paint', 05:43:47 INFO - 'tpaint', 05:43:47 INFO - 'sessionrestore', 05:43:47 INFO - 'sessionrestore_no_auto_restore', 05:43:47 INFO - 'tabpaint']}, 05:43:47 INFO - 'other_l64': {'tests': ['a11yr', 05:43:47 INFO - 'ts_paint', 05:43:47 INFO - 'tpaint', 05:43:47 INFO - 'sessionrestore', 05:43:47 INFO - 'sessionrestore_no_auto_restore', 05:43:47 INFO - 'tabpaint']}, 05:43:47 INFO - 'other_nol64': {'tests': ['a11yr', 05:43:47 INFO - 'ts_paint', 05:43:47 INFO - 'tpaint', 05:43:47 INFO - 'sessionrestore', 05:43:47 INFO - 'sessionrestore_no_auto_restore', 05:43:47 INFO - 'tabpaint']}, 05:43:47 INFO - 'svgr': {'tests': ['tsvgx', 05:43:47 INFO - 'tsvgr_opacity', 05:43:47 INFO - 'tart', 05:43:47 INFO - 'tscrollx', 05:43:47 INFO - 'cart']}, 05:43:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:43:47 INFO - 'tests': ['tsvgx', 05:43:47 INFO - 'tsvgr_opacity', 05:43:47 INFO - 'tart', 05:43:47 INFO - 'tscrollx', 05:43:47 INFO - 'cart']}, 05:43:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:47 INFO - 'tests': ['tp5o']}, 05:43:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:47 INFO - 'talos_options': ['--e10s'], 05:43:47 INFO - 'tests': ['tp5o']}, 05:43:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:47 INFO - 'talos_options': ['--xperf_path', 05:43:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:43:47 INFO - 'tests': ['tp5n']}, 05:43:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:47 INFO - 'talos_options': ['--e10s', 05:43:47 INFO - '--xperf_path', 05:43:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:43:47 INFO - 'tests': ['tp5n']}}, 05:43:47 INFO - 'talos.zip': {'path': '', 05:43:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:43:47 INFO - Running post-action listener: _resource_record_post_action 05:43:47 INFO - ##### 05:43:47 INFO - ##### Running create-virtualenv step. 05:43:47 INFO - ##### 05:43:47 INFO - Running pre-action listener: _resource_record_pre_action 05:43:47 INFO - Running main action method: create_virtualenv 05:43:47 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:43:47 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 05:43:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:43:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:43:47 INFO - Using real prefix '/usr' 05:43:47 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:43:47 INFO - Installing distribute.............................................................................................................................................................................................done. 05:43:49 INFO - Installing pip.................done. 05:43:49 INFO - Return code: 0 05:43:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:43: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')]} 05:43:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43: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')]} 05:43:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce81dacf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f486d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd7920>, '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 0x1fd8820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd8cb0>, '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': 'fa44defc139c4ba8574fe040000001db-1457443761.898035-2022830480', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:43: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', 'pip>=1.5'] in /builds/slave/test-pgo/build 05:43: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 pip>=1.5 05:43:49 INFO - Using env: {'DISPLAY': ':0', 05:43:49 INFO - 'HOME': '/home/cltbld', 05:43:49 INFO - 'LANG': 'en_US.UTF-8', 05:43:49 INFO - 'LANGUAGE': 'en_US:en', 05:43:49 INFO - 'LOGNAME': 'cltbld', 05:43:49 INFO - 'MAIL': '/var/mail/cltbld', 05:43:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:49 INFO - 'MOZ_NO_REMOTE': '1', 05:43:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:49 INFO - 'NO_EM_RESTART': '1', 05:43:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:43:49 INFO - 'PWD': '/builds/slave/test-pgo', 05:43:49 INFO - 'SHELL': '/bin/bash', 05:43:49 INFO - 'SHLVL': '1', 05:43:49 INFO - 'TERM': 'linux', 05:43:49 INFO - 'TMOUT': '86400', 05:43:49 INFO - 'USER': 'cltbld', 05:43:49 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1457443761.898035-2022830480', 05:43:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:49 INFO - '_': '/tools/buildbot/bin/python'} 05:43:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:50 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:43:50 INFO - Cleaning up... 05:43:50 INFO - Return code: 0 05:43:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:43:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fce81dacf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f486d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd7920>, '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 0x1fd8820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd8cb0>, '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': 'fa44defc139c4ba8574fe040000001db-1457443761.898035-2022830480', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:43:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:43:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:43:50 INFO - Using env: {'DISPLAY': ':0', 05:43:50 INFO - 'HOME': '/home/cltbld', 05:43:50 INFO - 'LANG': 'en_US.UTF-8', 05:43:50 INFO - 'LANGUAGE': 'en_US:en', 05:43:50 INFO - 'LOGNAME': 'cltbld', 05:43:50 INFO - 'MAIL': '/var/mail/cltbld', 05:43:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:50 INFO - 'MOZ_NO_REMOTE': '1', 05:43:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:50 INFO - 'NO_EM_RESTART': '1', 05:43:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:43:50 INFO - 'PWD': '/builds/slave/test-pgo', 05:43:50 INFO - 'SHELL': '/bin/bash', 05:43:50 INFO - 'SHLVL': '1', 05:43:50 INFO - 'TERM': 'linux', 05:43:50 INFO - 'TMOUT': '86400', 05:43:50 INFO - 'USER': 'cltbld', 05:43:50 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1457443761.898035-2022830480', 05:43:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:50 INFO - '_': '/tools/buildbot/bin/python'} 05:43:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:50 INFO - Downloading/unpacking psutil>=0.7.1 05:43:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:43:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:43:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:43:52 INFO - Installing collected packages: psutil 05:43:52 INFO - Running setup.py install for psutil 05:43:52 INFO - building 'psutil._psutil_linux' extension 05:43:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:43:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:43:52 INFO - building 'psutil._psutil_posix' extension 05:43:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:43:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:43:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:43:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:43:52 INFO - Successfully installed psutil 05:43:52 INFO - Cleaning up... 05:43:52 INFO - Return code: 0 05:43:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:43:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:52 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 0x7fce81dacf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f486d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd7920>, '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 0x1fd8820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd8cb0>, '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': 'fa44defc139c4ba8574fe040000001db-1457443761.898035-2022830480', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:43:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 05:43:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:43:52 INFO - Using env: {'DISPLAY': ':0', 05:43:52 INFO - 'HOME': '/home/cltbld', 05:43:52 INFO - 'LANG': 'en_US.UTF-8', 05:43:52 INFO - 'LANGUAGE': 'en_US:en', 05:43:52 INFO - 'LOGNAME': 'cltbld', 05:43:52 INFO - 'MAIL': '/var/mail/cltbld', 05:43:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:52 INFO - 'MOZ_NO_REMOTE': '1', 05:43:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:52 INFO - 'NO_EM_RESTART': '1', 05:43:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:43:52 INFO - 'PWD': '/builds/slave/test-pgo', 05:43:52 INFO - 'SHELL': '/bin/bash', 05:43:52 INFO - 'SHLVL': '1', 05:43:52 INFO - 'TERM': 'linux', 05:43:52 INFO - 'TMOUT': '86400', 05:43:52 INFO - 'USER': 'cltbld', 05:43:52 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1457443761.898035-2022830480', 05:43:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:52 INFO - '_': '/tools/buildbot/bin/python'} 05:43:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:43: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 05:43: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 05:43: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 05:43: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 05:43: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 05:43: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 05:43:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:43:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:43:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:43:54 INFO - Installing collected packages: mozsystemmonitor 05:43:54 INFO - Running setup.py install for mozsystemmonitor 05:43:54 INFO - Successfully installed mozsystemmonitor 05:43:54 INFO - Cleaning up... 05:43:54 INFO - Return code: 0 05:43:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:43:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fce81dacf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f486d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd7920>, '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 0x1fd8820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd8cb0>, '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': 'fa44defc139c4ba8574fe040000001db-1457443761.898035-2022830480', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:43:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 05:43:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:43:54 INFO - Using env: {'DISPLAY': ':0', 05:43:54 INFO - 'HOME': '/home/cltbld', 05:43:54 INFO - 'LANG': 'en_US.UTF-8', 05:43:54 INFO - 'LANGUAGE': 'en_US:en', 05:43:54 INFO - 'LOGNAME': 'cltbld', 05:43:54 INFO - 'MAIL': '/var/mail/cltbld', 05:43:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:54 INFO - 'MOZ_NO_REMOTE': '1', 05:43:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:54 INFO - 'NO_EM_RESTART': '1', 05:43:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:43:54 INFO - 'PWD': '/builds/slave/test-pgo', 05:43:54 INFO - 'SHELL': '/bin/bash', 05:43:54 INFO - 'SHLVL': '1', 05:43:54 INFO - 'TERM': 'linux', 05:43:54 INFO - 'TMOUT': '86400', 05:43:54 INFO - 'USER': 'cltbld', 05:43:54 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1457443761.898035-2022830480', 05:43:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:54 INFO - '_': '/tools/buildbot/bin/python'} 05:43:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:55 INFO - Downloading/unpacking blobuploader==1.2.4 05:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:56 INFO - Downloading blobuploader-1.2.4.tar.gz 05:43:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:43:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:43:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:43:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:43:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:57 INFO - Downloading docopt-0.6.1.tar.gz 05:43:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:43:57 INFO - Installing collected packages: blobuploader, requests, docopt 05:43:57 INFO - Running setup.py install for blobuploader 05:43:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:43:57 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:43:57 INFO - Running setup.py install for requests 05:43:58 INFO - Running setup.py install for docopt 05:43:58 INFO - Successfully installed blobuploader requests docopt 05:43:58 INFO - Cleaning up... 05:43:58 INFO - Return code: 0 05:43:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:43:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:58 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 0x7fce81dacf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f486d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd7920>, '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 0x1fd8820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd8cb0>, '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': 'fa44defc139c4ba8574fe040000001db-1457443761.898035-2022830480', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:43:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:43:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:43:58 INFO - Using env: {'DISPLAY': ':0', 05:43:58 INFO - 'HOME': '/home/cltbld', 05:43:58 INFO - 'LANG': 'en_US.UTF-8', 05:43:58 INFO - 'LANGUAGE': 'en_US:en', 05:43:58 INFO - 'LOGNAME': 'cltbld', 05:43:58 INFO - 'MAIL': '/var/mail/cltbld', 05:43:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:58 INFO - 'MOZ_NO_REMOTE': '1', 05:43:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:58 INFO - 'NO_EM_RESTART': '1', 05:43:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:43:58 INFO - 'PWD': '/builds/slave/test-pgo', 05:43:58 INFO - 'SHELL': '/bin/bash', 05:43:58 INFO - 'SHLVL': '1', 05:43:58 INFO - 'TERM': 'linux', 05:43:58 INFO - 'TMOUT': '86400', 05:43:58 INFO - 'USER': 'cltbld', 05:43:58 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1457443761.898035-2022830480', 05:43:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:58 INFO - '_': '/tools/buildbot/bin/python'} 05:43:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:43:58 INFO - Running setup.py (path:/tmp/pip-o71kzS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:43:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:43:58 INFO - Running setup.py (path:/tmp/pip-toVXR4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:43:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:43:58 INFO - Running setup.py (path:/tmp/pip-HgWfIv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:43:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:43:58 INFO - Running setup.py (path:/tmp/pip-QOOnvt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:43:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:43:58 INFO - Running setup.py (path:/tmp/pip-DwhC9O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:43:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:43:58 INFO - Running setup.py (path:/tmp/pip-jc1Ckd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:43:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:43:58 INFO - Running setup.py (path:/tmp/pip-awqsSe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:43:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:43:58 INFO - Running setup.py (path:/tmp/pip-8RGCVG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:43:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:43:59 INFO - Running setup.py (path:/tmp/pip-yJMfpu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:43:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:43:59 INFO - Running setup.py (path:/tmp/pip-NfnlXa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:43:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:43:59 INFO - Running setup.py (path:/tmp/pip-0zsiQd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:43:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:43:59 INFO - Running setup.py (path:/tmp/pip-cvMdOt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:43:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:43:59 INFO - Running setup.py (path:/tmp/pip-A9ypS_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:43:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:43:59 INFO - Running setup.py (path:/tmp/pip-PSakCl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:43:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:43:59 INFO - Running setup.py (path:/tmp/pip-lCep1y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:43:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:43:59 INFO - Running setup.py (path:/tmp/pip-H9LfU8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:43:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:43:59 INFO - Running setup.py (path:/tmp/pip-3Z4ENE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:43:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:43:59 INFO - Running setup.py install for manifestparser 05:43:59 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:43:59 INFO - Running setup.py install for mozcrash 05:43:59 INFO - Running setup.py install for mozdebug 05:44:00 INFO - Running setup.py install for mozdevice 05:44:00 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:44:00 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:44:00 INFO - Running setup.py install for mozfile 05:44:00 INFO - Running setup.py install for mozhttpd 05:44:00 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:44:00 INFO - Running setup.py install for mozinfo 05:44:00 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:44:00 INFO - Running setup.py install for mozInstall 05:44:00 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:44:00 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:44:00 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:44:00 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:44:00 INFO - Running setup.py install for mozleak 05:44:00 INFO - Running setup.py install for mozlog 05:44:00 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:44:00 INFO - Running setup.py install for moznetwork 05:44:00 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:44:00 INFO - Running setup.py install for mozprocess 05:44:00 INFO - Running setup.py install for mozprofile 05:44:01 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:44:01 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:44:01 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:44:01 INFO - Running setup.py install for mozrunner 05:44:01 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:44:01 INFO - Running setup.py install for mozscreenshot 05:44:01 INFO - Running setup.py install for moztest 05:44:01 INFO - Running setup.py install for mozversion 05:44:01 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:44:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:44:01 INFO - Cleaning up... 05:44:01 INFO - Return code: 0 05:44:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:44:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:01 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 0x7fce81dacf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f486d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd7920>, '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 0x1fd8820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd8cb0>, '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': 'fa44defc139c4ba8574fe040000001db-1457443761.898035-2022830480', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:44:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:44:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:44:01 INFO - Using env: {'DISPLAY': ':0', 05:44:01 INFO - 'HOME': '/home/cltbld', 05:44:01 INFO - 'LANG': 'en_US.UTF-8', 05:44:01 INFO - 'LANGUAGE': 'en_US:en', 05:44:01 INFO - 'LOGNAME': 'cltbld', 05:44:01 INFO - 'MAIL': '/var/mail/cltbld', 05:44:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:01 INFO - 'MOZ_NO_REMOTE': '1', 05:44:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:01 INFO - 'NO_EM_RESTART': '1', 05:44:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:44:01 INFO - 'PWD': '/builds/slave/test-pgo', 05:44:01 INFO - 'SHELL': '/bin/bash', 05:44:01 INFO - 'SHLVL': '1', 05:44:01 INFO - 'TERM': 'linux', 05:44:01 INFO - 'TMOUT': '86400', 05:44:01 INFO - 'USER': 'cltbld', 05:44:01 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1457443761.898035-2022830480', 05:44:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:01 INFO - '_': '/tools/buildbot/bin/python'} 05:44:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:44:01 INFO - Running setup.py (path:/tmp/pip-66_fZg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:44:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 05:44:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:44:01 INFO - Running setup.py (path:/tmp/pip-LqzEUu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:44:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:44:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:44:01 INFO - Running setup.py (path:/tmp/pip-VIWc4d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:44:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:44:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:44:01 INFO - Running setup.py (path:/tmp/pip-1KtxKy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:44:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:44:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:44:01 INFO - Running setup.py (path:/tmp/pip-HCs0mm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 05:44:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:44:02 INFO - Running setup.py (path:/tmp/pip-SF0AcE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 05:44:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:44:02 INFO - Running setup.py (path:/tmp/pip-rt7r4l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 05:44:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:44:02 INFO - Running setup.py (path:/tmp/pip-sjz76P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 05:44:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:44:02 INFO - Running setup.py (path:/tmp/pip-Rh0bQQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 05:44:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:44:02 INFO - Running setup.py (path:/tmp/pip-wLXVFs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:44:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:44:02 INFO - Running setup.py (path:/tmp/pip-oGGf75-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 05:44:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:44:02 INFO - Running setup.py (path:/tmp/pip-Jdc2VB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 05:44:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:44:02 INFO - Running setup.py (path:/tmp/pip-AGDwTP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 05:44:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:44:02 INFO - Running setup.py (path:/tmp/pip-Qxpfcn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 05:44:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:44:02 INFO - Running setup.py (path:/tmp/pip-8xl2mw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 05:44:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:44:02 INFO - Running setup.py (path:/tmp/pip-GjuPWu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 05:44:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:44:02 INFO - Running setup.py (path:/tmp/pip-pfjc8P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 05:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:44:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:44: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 05:44: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 05:44: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 05:44: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 05:44: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 05:44: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 05:44:04 INFO - Downloading blessings-1.6.tar.gz 05:44:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:44:04 INFO - Installing collected packages: blessings 05:44:04 INFO - Running setup.py install for blessings 05:44:04 INFO - Successfully installed blessings 05:44:04 INFO - Cleaning up... 05:44:05 INFO - Return code: 0 05:44:05 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:44:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:44:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:44:05 INFO - Reading from file tmpfile_stdout 05:44:05 INFO - Current package versions: 05:44:05 INFO - argparse == 1.2.1 05:44:05 INFO - blessings == 1.6 05:44:05 INFO - blobuploader == 1.2.4 05:44:05 INFO - docopt == 0.6.1 05:44:05 INFO - manifestparser == 1.1 05:44:05 INFO - mozInstall == 1.12 05:44:05 INFO - mozcrash == 0.17 05:44:05 INFO - mozdebug == 0.1 05:44:05 INFO - mozdevice == 0.48 05:44:05 INFO - mozfile == 1.2 05:44:05 INFO - mozhttpd == 0.7 05:44:05 INFO - mozinfo == 0.9 05:44:05 INFO - mozleak == 0.1 05:44:05 INFO - mozlog == 3.1 05:44:05 INFO - moznetwork == 0.27 05:44:05 INFO - mozprocess == 0.22 05:44:05 INFO - mozprofile == 0.28 05:44:05 INFO - mozrunner == 6.11 05:44:05 INFO - mozscreenshot == 0.1 05:44:05 INFO - mozsystemmonitor == 0.0 05:44:05 INFO - moztest == 0.7 05:44:05 INFO - mozversion == 1.4 05:44:05 INFO - psutil == 3.1.1 05:44:05 INFO - requests == 1.2.3 05:44:05 INFO - wsgiref == 0.1.2 05:44:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:44:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:05 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 0x7fce81dacf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f486d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd7920>, '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 0x1fd8820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd8cb0>, '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': 'fa44defc139c4ba8574fe040000001db-1457443761.898035-2022830480', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:44:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 05:44:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:44:05 INFO - Using env: {'DISPLAY': ':0', 05:44:05 INFO - 'HOME': '/home/cltbld', 05:44:05 INFO - 'LANG': 'en_US.UTF-8', 05:44:05 INFO - 'LANGUAGE': 'en_US:en', 05:44:05 INFO - 'LOGNAME': 'cltbld', 05:44:05 INFO - 'MAIL': '/var/mail/cltbld', 05:44:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:05 INFO - 'MOZ_NO_REMOTE': '1', 05:44:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:05 INFO - 'NO_EM_RESTART': '1', 05:44:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:44:05 INFO - 'PWD': '/builds/slave/test-pgo', 05:44:05 INFO - 'SHELL': '/bin/bash', 05:44:05 INFO - 'SHLVL': '1', 05:44:05 INFO - 'TERM': 'linux', 05:44:05 INFO - 'TMOUT': '86400', 05:44:05 INFO - 'USER': 'cltbld', 05:44:05 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1457443761.898035-2022830480', 05:44:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:05 INFO - '_': '/tools/buildbot/bin/python'} 05:44:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:44:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 05:44:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 05:44:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:44:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 05:44:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 05:44:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 05:44:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 05:44:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 05:44:05 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:44:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:44:05 INFO - Cleaning up... 05:44:05 INFO - Return code: 0 05:44:05 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:44:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:05 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 0x7fce81dacf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f486d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd7920>, '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 0x1fd8820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd8cb0>, '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': 'fa44defc139c4ba8574fe040000001db-1457443761.898035-2022830480', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:44:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 05:44:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:44:05 INFO - Using env: {'DISPLAY': ':0', 05:44:05 INFO - 'HOME': '/home/cltbld', 05:44:05 INFO - 'LANG': 'en_US.UTF-8', 05:44:05 INFO - 'LANGUAGE': 'en_US:en', 05:44:05 INFO - 'LOGNAME': 'cltbld', 05:44:05 INFO - 'MAIL': '/var/mail/cltbld', 05:44:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:05 INFO - 'MOZ_NO_REMOTE': '1', 05:44:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:05 INFO - 'NO_EM_RESTART': '1', 05:44:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:44:05 INFO - 'PWD': '/builds/slave/test-pgo', 05:44:05 INFO - 'SHELL': '/bin/bash', 05:44:05 INFO - 'SHLVL': '1', 05:44:05 INFO - 'TERM': 'linux', 05:44:05 INFO - 'TMOUT': '86400', 05:44:05 INFO - 'USER': 'cltbld', 05:44:05 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1457443761.898035-2022830480', 05:44:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:05 INFO - '_': '/tools/buildbot/bin/python'} 05:44:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:05 INFO - Downloading/unpacking jsonschema 05:44: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 05:44: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 05:44: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 05:44: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 05:44: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 05:44: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 05:44:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:44:07 INFO - Downloading/unpacking functools32 (from jsonschema) 05:44:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:07 INFO - Downloading functools32-3.2.3-2.tar.gz 05:44:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:44:07 INFO - warning: no files found matching '*.txt' 05:44:07 INFO - no previously-included directories found matching 'build' 05:44:07 INFO - no previously-included directories found matching 'dist' 05:44:07 INFO - no previously-included directories found matching '.git*' 05:44:07 INFO - Installing collected packages: jsonschema, functools32 05:44:07 INFO - Running setup.py install for functools32 05:44:07 INFO - warning: no files found matching '*.txt' 05:44:07 INFO - no previously-included directories found matching 'build' 05:44:07 INFO - no previously-included directories found matching 'dist' 05:44:07 INFO - no previously-included directories found matching '.git*' 05:44:07 INFO - Successfully installed jsonschema functools32 05:44:07 INFO - Cleaning up... 05:44:07 INFO - Return code: 0 05:44:07 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:44:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:07 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 0x7fce81dacf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f486d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd7920>, '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 0x1fd8820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd8cb0>, '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': 'fa44defc139c4ba8574fe040000001db-1457443761.898035-2022830480', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:44:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 05:44:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:44:07 INFO - Using env: {'DISPLAY': ':0', 05:44:07 INFO - 'HOME': '/home/cltbld', 05:44:07 INFO - 'LANG': 'en_US.UTF-8', 05:44:07 INFO - 'LANGUAGE': 'en_US:en', 05:44:07 INFO - 'LOGNAME': 'cltbld', 05:44:07 INFO - 'MAIL': '/var/mail/cltbld', 05:44:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:07 INFO - 'MOZ_NO_REMOTE': '1', 05:44:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:07 INFO - 'NO_EM_RESTART': '1', 05:44:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:44:07 INFO - 'PWD': '/builds/slave/test-pgo', 05:44:07 INFO - 'SHELL': '/bin/bash', 05:44:07 INFO - 'SHLVL': '1', 05:44:07 INFO - 'TERM': 'linux', 05:44:07 INFO - 'TMOUT': '86400', 05:44:07 INFO - 'USER': 'cltbld', 05:44:07 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1457443761.898035-2022830480', 05:44:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:07 INFO - '_': '/tools/buildbot/bin/python'} 05:44:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:08 INFO - Downloading/unpacking flake8 05:44:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:44:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:44:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:44:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:44:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:44:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:44:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:44:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:44:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:44:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:44:10 INFO - no previously-included directories found matching 'docs/_build' 05:44:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:44:11 INFO - Running setup.py install for pep8 05:44:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:44:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:44:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:44:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:44:11 INFO - no previously-included directories found matching 'docs/_build' 05:44:11 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:44:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:44:11 INFO - Cleaning up... 05:44:11 INFO - Return code: 0 05:44:11 INFO - Running post-action listener: _resource_record_post_action 05:44:11 INFO - Running post-action listener: _start_resource_monitoring 05:44:11 INFO - Starting resource monitoring. 05:44:11 INFO - ##### 05:44:11 INFO - ##### Running install step. 05:44:11 INFO - ##### 05:44:11 INFO - Running pre-action listener: _resource_record_pre_action 05:44:11 INFO - Running main action method: install 05:44:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:44:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:44:11 INFO - Reading from file tmpfile_stdout 05:44:11 INFO - Detecting whether we're running mozinstall >=1.0... 05:44:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:44:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:44:11 INFO - Reading from file tmpfile_stdout 05:44:11 INFO - Output received: 05:44:11 INFO - Usage: mozinstall [options] installer 05:44:11 INFO - Options: 05:44:11 INFO - -h, --help show this help message and exit 05:44:11 INFO - -d DEST, --destination=DEST 05:44:11 INFO - Directory to install application into. [default: 05:44:11 INFO - "/builds/slave/test-pgo"] 05:44:11 INFO - --app=APP Application being installed. [default: firefox] 05:44:11 INFO - mkdir: /builds/slave/test-pgo/build/application 05:44:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 05:44:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 05:44:27 INFO - Reading from file tmpfile_stdout 05:44:27 INFO - Output received: 05:44:27 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:44:27 INFO - Running post-action listener: _resource_record_post_action 05:44:27 INFO - ##### 05:44:27 INFO - ##### Running run-tests step. 05:44:27 INFO - ##### 05:44:27 INFO - Running pre-action listener: _resource_record_pre_action 05:44:27 INFO - Running main action method: run_tests 05:44:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:44:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:44:27 INFO - Python 2.7.3 05:44:27 INFO - Return code: 0 05:44:27 INFO - grabbing minidump binary from tooltool 05:44:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:27 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 0x1fd7920>, '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 0x1fd8820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd8cb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:44:27 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 05:44:27 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:44:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:44:27 INFO - Return code: 0 05:44:27 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:44:27 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:44:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:44:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:44:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:44:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:44:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:44:28 INFO - Return code: 0 05:44:28 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/bJRKDbyBRE2GQA4HmJVgQg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 05:44:28 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/bJRKDbyBRE2GQA4HmJVgQg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 05:44:28 INFO - Using env: {'DISPLAY': ':0', 05:44:28 INFO - 'HOME': '/home/cltbld', 05:44:28 INFO - 'LANG': 'en_US.UTF-8', 05:44:28 INFO - 'LANGUAGE': 'en_US:en', 05:44:28 INFO - 'LOGNAME': 'cltbld', 05:44:28 INFO - 'MAIL': '/var/mail/cltbld', 05:44:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:44:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:44:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:28 INFO - 'MOZ_NO_REMOTE': '1', 05:44:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:44:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:28 INFO - 'NO_EM_RESTART': '1', 05:44:28 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:44:28 INFO - 'PWD': '/builds/slave/test-pgo', 05:44:28 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:44:28 INFO - 'SHELL': '/bin/bash', 05:44:28 INFO - 'SHLVL': '1', 05:44:28 INFO - 'TERM': 'linux', 05:44:28 INFO - 'TMOUT': '86400', 05:44:28 INFO - 'USER': 'cltbld', 05:44:28 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1457443761.898035-2022830480', 05:44:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:28 INFO - '_': '/tools/buildbot/bin/python'} 05:44:28 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/bJRKDbyBRE2GQA4HmJVgQg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:44:28 INFO - mozversion application_buildid: 20160308030418 05:44:28 INFO - mozversion application_changeset: 05c087337043dd8e71cc27bdb5b9d55fd00aaa26 05:44:28 INFO - mozversion application_display_name: Nightly 05:44:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:44:28 INFO - mozversion application_name: Firefox 05:44:28 INFO - mozversion application_remotingname: firefox 05:44:28 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:44:28 INFO - mozversion application_vendor: Mozilla 05:44:28 INFO - mozversion application_version: 48.0a1 05:44:28 INFO - mozversion platform_buildid: 20160308030418 05:44:28 INFO - mozversion platform_changeset: 05c087337043dd8e71cc27bdb5b9d55fd00aaa26 05:44:28 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:44:28 INFO - mozversion platform_version: 48.0a1 05:44:28 INFO - using testdate: 1457444668 05:44:28 INFO - actual date: 1457444668 05:44:28 INFO - starting webserver on 'localhost:48296' 05:44:28 INFO - SUITE-START | Running 2 tests 05:44:28 INFO - TEST-START | dromaeo_css 05:44:28 INFO - operating with platform_type : linux_ 05:44:28 INFO - Initialising browser for dromaeo_css test... 05:44:28 INFO - TEST-INFO | started process 8715 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmYL9Ss/profile http://localhost:48296/getInfo.html) 05:44:33 INFO - PROCESS | 8715 | __metrics Screen width/height:1600/1200 05:44:33 INFO - PROCESS | 8715 | colorDepth:24 05:44:33 INFO - PROCESS | 8715 | Browser inner width/height: 1024/697 05:44:33 INFO - PROCESS | 8715 | __metrics 05:44:34 INFO - PROCESS | 8715 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:44:35 INFO - TEST-INFO | 8715: exit 0 05:44:35 INFO - Browser initialized. 05:44:35 INFO - Running cycle 1/1 for dromaeo_css test... 05:44:35 INFO - TEST-INFO | started process 8809 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmYL9Ss/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:44:46 INFO - PROCESS | 8809 | RSS: Main: 156962816 05:44:46 INFO - PROCESS | 8809 | 05:45:38 INFO - PROCESS | 8809 | 1457444738225 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:47:46 INFO - PROCESS | 8809 | Cycle 1(1): loaded http://localhost:48296/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48296/tests/dromaeo/cssquery-ext.html) 05:47:46 INFO - PROCESS | 8809 | RSS: Main: 246542336 05:47:46 INFO - PROCESS | 8809 | 05:50:49 INFO - PROCESS | 8809 | Cycle 1(1): loaded http://localhost:48296/tests/dromaeo/cssquery-ext.html (next: http://localhost:48296/tests/dromaeo/cssquery-jquery.html) 05:50:49 INFO - PROCESS | 8809 | RSS: Main: 239304704 05:50:49 INFO - PROCESS | 8809 | 05:53:51 INFO - PROCESS | 8809 | Cycle 1(1): loaded http://localhost:48296/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48296/tests/dromaeo/cssquery-mootools.html) 05:53:52 INFO - PROCESS | 8809 | RSS: Main: 246706176 05:53:52 INFO - PROCESS | 8809 | 05:56:54 INFO - PROCESS | 8809 | Cycle 1(1): loaded http://localhost:48296/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48296/tests/dromaeo/cssquery-prototype.html) 05:56:54 INFO - PROCESS | 8809 | RSS: Main: 220241920 05:56:54 INFO - PROCESS | 8809 | 05:59:57 INFO - PROCESS | 8809 | Cycle 1(1): loaded http://localhost:48296/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48296/tests/dromaeo/cssquery-yui.html) 05:59:57 INFO - PROCESS | 8809 | RSS: Main: 218267648 05:59:57 INFO - PROCESS | 8809 | 06:03:00 INFO - PROCESS | 8809 | Cycle 1(1): loaded http://localhost:48296/tests/dromaeo/cssquery-yui.html (next: http://localhost:48296/tests/dromaeo/cssquery-dojo.html) 06:03:00 INFO - PROCESS | 8809 | RSS: Main: 297791488 06:03:00 INFO - PROCESS | 8809 | 06:03:00 INFO - PROCESS | 8809 | __start_tp_report 06:03:00 INFO - PROCESS | 8809 | _x_x_mozilla_page_load 06:03:00 INFO - PROCESS | 8809 | _x_x_mozilla_page_load_details 06:03:00 INFO - PROCESS | 8809 | |i|pagename|runs| 06:03:00 INFO - PROCESS | 8809 | |0;dojo.html;2983.627046619173;3020.8640611172495;3031.6362036555615;3043.0414419457857;3066.8006579572325;4989.575886049681;5157.845264642062;5158.277841102249;5174.844754657357;5210.426853046167;5088.440271570124;5114.872128196787;5153.149730294497;5168.173092305232;5196;4622.6070783983405;4671.135839869627;4707.693999890013;4761.6904901181315;4876.804927802884;4821.807127714905;4824.2040063389495;4851.805927762903;4878.268259761029;4879.634027447938;4612.492625811158;4716.740579268156;4747.881302967419;4782.1631214537665;4792.856214313576;4705.952940470585;4706.247000479907;4706.78819453122;4723.834665786681;4745.311929770164;4578.336141259499;4678.345031695565;4689.718616882998;4703.2474804031535;4748.121597504472;5012.072766538202;5083.05963396769;5089.109405853961;5093.236014597803;5101.82143624975;5522.502974732293;5529.972350138223;5540.279763630702;5545.889082218373;5548.6948217848;5360.115580929181;5576.944230557683;5586.497215250647;5593.077142271521;5596.272484576979;5165.328507294028;5197.922031169535;5206.3492063491685;5230.476952304777;5252.080885844962;5631.662100273997;5633.155026746021;5635.1828984796975;5639.492445679908;5659.462351076641;5339.652922560022;5419.376771671308;5428.4028756836715;5434.402215756264;5447.210154527571;5478.397376288605;5491.2312276281355;5498.230247765316;5508.118701007819;5548.250986116904;5452.127659574449;5458.0721277382145;5463.043967305785;5463.726813659301;5465.453454654582;5361.865953351197;5467.289252397242;5474.178873169057;5508.476694713996;5513.145462453326;4266.189424009491;4273.914521709548;4282.07935293907;4284.250256205151;4318.956810431919;3758.9060273493383;3794.5446546414605;3796.924061518754;3816.3321418751607;3831.63599458051;5105.310783044316;5144.074066668036;5222.608304377187;5255.710935898486;5301.893962120813;5534.75093620788;5545.140503222007;5558.166275058774;5567.47109024642;5579.46995035471;5253.579713622978;5259.684418934799;5262.947370526245;5274.498922602346;5304.787808487695;4622.19111655459;4715.552022557851;4730.101280756645;4746.2168742157155;4753.857384278477;5758.452946970031;5770.855728606818;5777.220075289866;5778.884422311614;5787.594868359174;5479.013777520085;5480.479354461399;5487.094629386106;5493.697846618475;5521.116621340727;5582.302212223472;5733.2260144881575;5733.799317023884;5818.418158184148;5839.065749480233;5435.483629055233;5493.7802487900035;5499.752511136929;5504.2018907257425;5530.308711411074;5335.253064570886;5523.061079616556;5528.364238112668;5531.751071201725;5578.832635020955;5290.629655924048;5340.946590534045;5374.758135883816;5408.891822163456;5419.783208671766;5403.324584426947;5424.2134890439875;5430.484104010113;5438;5440.483154100354;5084.949150508448;5330.440303768049;5353.2505449237915;5357.946420535744;5380.811671591476;5384;5415.972920135374;5419.539339156216;5427.728613569227;5472.863178420572;5288.259643649815;5298.231756395224;5304.496072873071;5305.522502974751;5362.865928351823 06:03:00 INFO - PROCESS | 8809 | |1;ext.html;512.9128048231801;529.4097081753846;535.0663092902884;561.2843624378917;561.2899681902392;29086;37430.43854342187;38158.61841381586;38260;38302.616973830256;40255;41029.79485102578;41065.38401923973;41082.17835643285;41095;7408.888866667005;8427.873581896261;8653.610587523544;8674.349423793241;9943.602255909791;9974.650887218948;10124.190064794799;10135.898641013606;10139.695809125702;10143.847842282372;10159.13647339977;10256.487175641225;10270.486475676224;10274.691759247235;10284.742881427987;10043.598256069748;10143.89856101437;10147.746306342327;10150.137238334713;10151.492425378776;9997.600095996151;10375.221858360654;10418.801837788675;10425.426601536912;10430.478476076165;40191;40534.39198412026;40664.593354066375;40705;40734;3095.829729364884;3188.2985743136474;3211.5824942757527;3238.870405576685;3299.290652509698;30018.849905750332;30601.540976885364;30934.845325773225;30951.597955096007;31329.06012819619;3559.7624165291027;3574.857005719768;3592.8383222755037;3628.4920111184456;3647.5622925248877;291957;292239;293330;296483;297741;60393.396066039655;60690.696546517865;60755.39244607498;60793;60801.695991520646;67639;68607;68647;68730.31269687338;68735.65632171807;13975.37110830015;13991.720165596631;14021.649458763612;14114.50599229022;14127.858721412655;10584.841227381596;10597.152227821756;10635.149188064936;10639.946800265949;10653.360798352123;20068.498287542927;20296.594068118557;20304.898475507824;20386.286479973427;20399.694004589943;7669.501482403626;7791.142974272825;7861.803454913558;7917.881231781528;7922.564258965697;859.8027395094178;868.8957325121025;1012.2509343086064;1048.8777008600875;1068.7435015596202;28359.29101772431;28582.857085714855;28599.57100643492;28796.424071518453;28929.987450439556;997.152420442618;1051.9217801753264;1075.774087441646;1085.375908852413;1086.1419478611808;14321.212333321559;14772.48296309624;14861.851381486264;15024.62438439026;15136.924315378574;352866;353241;353528;356503;357924;50730.49269507331;51674.74162629163;52020.73989630028;52070.739646301525;52421.47578524242;1213.205350495427;1238.8637249902504;1241.8944389726973;1317.736452709462;1338.2171429713726;26912.596311055742;28562.285942851595;28840.855795720887;29312.41375172442;29393.265168370963;43006.78496607622;43218.56781432145;43257.3511397323;43274.78362608167;43381.34927976146;211352;211600.70998225166;211677;211929;211935;30543.847280763453;43453.78273108614;43566.56433435625;43998.78000609976;44824;39733.60266397415;39779.40330895097;40744.79627601843;41116.794416027726;41156.1768764617;35718.821405892806;36532.269354613294;37064;37155.62844371521;37291.06772330605;35957.820210898775;36582.8170859144;36745;36845.81577092098;37412.43881341728;34859.4771078429;35091.64908350986;35475.82262088673;35660;35800.28399431945;31849.68150318467;32989.34021319608;33036.50445243275;33199.50200747039;33321.333573328884;25013.624795628442;25388.49223015566;25479.872600636878;25672.358191045372;25823.741762582133 06:03:00 INFO - PROCESS | 8809 | |2;jquery.html;341.1301181985936;348.5851836314785;351.2886405029816;358.31740534282204;362.3550080856077;16983.745243821337;17095;17499.825001749963;17673.91163044186;17678.734818977693;16982.83017169828;16995.15024248789;17159.399421020265;17189.82810171898;17216.82783172168;5217.58259339252;5226.895462090765;5469.535089517396;5471.5896307776875;5472.26124473197;5367.543758780489;5449.100898351767;5454.645448045884;5456.508914197721;5457.754401051942;5428.077226871442;5430.864228394283;5746.051901436258;5986.132010858423;5987.580869339148;5967.40325967402;5990.580659353847;5993.370696076914;6006.369331220247;6045.486133678643;5150.97424512875;5254.605904557174;5282.920756188661;5300.3639563252655;5345.064613692588;11923.94038029813;12740.745185096339;12755.362231888368;12833.550825721055;12835.294058826761;1865.6082222733241;1944.824965753089;1967.8130577595105;1991.2035185925602;2125.4792575819024;9384.718458446258;9385.953070234606;9408.341416100875;10775.515101820436;12351.814722779165;1752.1151818331662;1769.2038582637865;1785.874988750788;1793.5874748807848;1864.0586503815487;46501.767491162325;48278.7586062071;56946.430535694526;61303;62762.37237627611;9908.306418550776;10121.645742398981;10144.898551014396;10198.541065652063;10244.59021639141;13383.19700817954;13463.326833658279;13482.595522134352;13487.730245395038;13496;6347.630065839839;6537.771178008747;7157.856842863113;7435.4795164337975;7435.776926692208;7264.782056538313;7305.780826575211;7393.3527199949285;7409.777706668809;7475.70097196117;4175.248455278019;4176.916461670749;4183.477065366829;4246.936295955563;4262.424572682648;1814.1926842554935;1815.4009176971567;1816.8470362620337;1857.3035111833062;1866.766654168229;858.9484630922165;909.3589019741066;978.6379039755194;994.8708216174693;1029.53156313877;16159.272832722556;16532.173391330387;16655.583610409838;16689.415870444718;17176.31294748221;865.7402779166225;892.4823602310644;894.065701342099;894.5035505294624;923.6259314977444;9212.130905019907;9486;9488.667896623723;9612.279079068958;9691.612335506641;145256;146398;146985;147373;147711;68904.6554767223;70555;72662.63668681729;72970.63514682393;74168.25831741614;945.7824700318828;948.0756262644005;972.7179118055684;986.9407835529892;992.4392718114242;11869.406529673655;14188;14607.92696036513;14687.92656036713;14963.476278330207;31378.52932205973;31742;32060.839695801373;32611.510827338083;32750.34499310048;38177.427338590496;42909.785451072545;44565.777171113936;44567.77716111398;45294;7932.920670793449;7993.92006079955;8098.919010809816;8174.427790054639;8234.423590348619;9205.493697846683;12421.192622479872;12534;12561.497540098293;12594.685132871751;10477.738056548647;10586.153107751208;10807.135429165804;10828.133749300194;11017.338959662125;10563.683089507327;10649.520771565143;10650.520726567169;10754.89245107539;10774.511415661513;10716.196285278791;10843.45782710877;10990.065844403316;10997.450127493754;11249.156313276373;7872.685092596232;7957.880631790644;7987.482378348095;8037.799055023671;8182.7545173644885;8426.662933482592;10061.245406594388;10792.190585705946;10809.35143891369;10850.45747712627 06:03:00 INFO - PROCESS | 8809 | |3;mootools.html;1227.0183852917664;1465.0770014890618;1469.8750606198473;1634.3380930723054;1772.530279475939;6948.583085014896;7604.125525564562;7743.728969486069;7757.418193635472;7759.689612415511;7612.238776122385;7796.142424333319;7801.804954876131;7803.06363236411;7842.372610191185;1993.1130646862152;2253.3690566641367;2310.688057112285;2331.9183828566;2355.5053438777877;2272.579572779041;2284.303287497321;2302.343832007878;2313.2597568777996;2314.5486630107134;2249.167807911075;2326.3718795925174;2328;2328.8951997160084;2330.207729372013;2244.921427750029;2262.1856131792542;2279.259240746764;2293.392251053472;2293.7247530296304;2300.861948283108;2339.4502291961376;2339.7426283108844;2351.58847201739;2362.8582285062953;7647.311741943252;7697.538147711155;7707.845843083163;7712.421568382394;7718.6912523498995;4792.688475249098;4934.037862616791;4936.555709986119;4940.752962351868;4942.456329803718;3087.505999040143;3167;3187.0438868339406;3219.356128774231;3232.531282963957;1063.8989296016866;1785.5357607022138;1805.3049575913237;1805.5486128467883;1817.818218178185;10456.424896630682;10589.894101058968;10595.205359598061;10611.363318200933;10617.946910265398;4327.32926396409;4418.889527761768;4456.888577785581;4485.6860019798305;4511.075229577928;9185.127412895765;9187.724368268962;9189.127032931861;9190.40262382943;9193;4293.763842988666;4814.735189564538;4828.565429111397;4861.927071093936;4868.391451068616;4351.6301114405;4439.178751930838;4450.043240703199;4467.553244675506;4475.731456112644;3756.9624303756614;3821.2357528494413;3823.6941044716355;3827.6746476549806;3885.0287428142965;1204.5302332090491;1210.1649861595472;1223.113242898909;1225.2158618484177;1240.0823390690823;1282.499825068224;1290.2645492069619;1292.373198998485;1302.3813688498078;1316.1379296560767;7481.364084052916;7585.6965721371635;7601.619919004028;7607.35337496308;7611.048618922635;489.3418352316129;496.9304297398367;498.81793145502354;502.98742531437006;510.2550276596137;5801.216835727208;5869.6771677558145;5884.176215329857;5930.792422265286;5943.55423343251;9032.954835225783;9524.238060955107;9648.98685638012;9672;9708.757281067888;9528;9550.761230969281;9557.569909353957;9559.904400955902;9638.084381983701;7223.349898509159;7542.849143017109;7587.748021576378;7590.354819840375;7599.924000760032;7112.6088065154845;7114.253003434772;7144.142702875688;7168.032315637531;7174.928250717426;8466.661333546836;8629.223369896488;8719.040905500517;8739.21347078766;8769.12308769118;8684.2184203422;8710.651573936972;8783.077776833341;8922.509261990654;8934.821303574023;5959.195508606283;6103.267607887082;6104.359042300672;6582.144321238208;6606;7273.490855640054;7459.254074592497;7467.887981680387;7470.887936680845;7482;6693.698783554654;6835.487338449736;6857.314268573103;6938.826529336807;6967.372936435745;6713.530052896251;6731.158605174353;6801.319868013357;6833.69248383814;6843.8973415399805;6987.161540615159;7010;7017.543859649107;7024.1571011478945;7132.643367831692;6608.966955165193;6613.338666133348;6657;6665.200175978914;6684.4318232950745;6633.469322454095;6672.466202703869;6693.598384096775;6697;6704.66476676174 06:03:00 INFO - PROCESS | 8809 | |4;prototype.html;338.3976521791211;342.2726705750281;343.94840773883914;345.64053384480144;355.4756733817619;5871.471567558919;5892.55805814564;5903.085021821619;5935.584509084366;5964.761409543613;5867.7066146692605;5871.383504732005;5874.148248503964;5875.88248235035;5879.8530036749;4275;4409.603135717784;4508.909821803562;4561.1105834362315;4576.61098806601;4492.573205545468;4492.707973981697;4526.366308716782;4539.818407263706;4549.545045495457;4497.70764900282;4540.250858608326;4548.204064288753;4550.203714349992;4553.4991150973365;4294.67789915756;4405.273129933557;4510.436195475566;4511.954880451186;4522.4346956630425;3945.1517923646265;3945.250402423559;3947.072437977073;3952.664023558001;3957.4657421248053;5632.3804381518;5634.183043458716;5635.71821408932;5639.71801409932;5640.746166422521;5255.553277971377;5264.789408423659;5267.130923397634;5268.894622107537;5270.4729527047375;6249.781257656005;6265.71804268809;6271.34150914152;6276.215473065867;6276.403741644536;4193.5387107418155;4337.7180483268485;4340.6093451589195;4385.166818304512;4398.450193725785;6477.708503117371;6499.252585952581;6541;6541.247756508015;6549.34506549346;4418.668599855024;4421.690481666253;4424.513303536608;4424.6902716810155;4426.601605855489;4477.686561940698;4484.686071974996;4488.349189367524;4488.573585509372;4488.977555112204;5204;5215.217717342353;5222.97388513055;5226.660267082628;5228.9477105229225;6081.969590152109;6316.210473690789;6317.989121740591;6319.684015799284;6324.747010119636;1539.5458339789789;1541.9074855508704;1550.0777037662572;1551.2631500037392;1552.4721594657644;947.9383840050513;988.8022395520925;1002.5989604158395;1023.4371095897376;1032.3444612670858;5932.644041357446;6010.308814486302;6017.037274036134;6019.307779605314;6025.487833534111;6417.839554011187;6419.101325814389;6427.100205971168;6429.871402571923;6437.710303036374;5981.940180598225;6016.2479690038745;6039.396060393926;6051.273847138372;6056.424639659225;3412.5904891412692;3439.793612383265;3447.5690538682666;3448.189675426273;3452.5511683480986;6666.366695163952;6779.864402711918;6797.320267973262;6850.623215723083;6860.485463590251;6640.63476508787;6648.1025061616065;6664.166979127609;6664.500162487833;6681.933180668131;6912.723491060402;6914.654267286615;6915.204751453547;6917.446604271646;6918.965405172942;6493.40263894446;6504.317046710027;6510.804675859732;6520.380563846427;6520.804375868732;6207.255129384323;6398.840028999312;6479.125318082187;6484.643344616092;6489.221293444817;6836.350546698056;6892.448604111759;6908.689108990007;6914.859048256982;6927;4519.932201016922;4523.660725445539;4531.274996000756;4531.478879928851;4533.909321813611;6390.329015453311;6394.328595497592;6409.679516024274;6445.677716114082;6449.097126402401;6102;6158.568900177123;6177.598456100339;6180.4746596538;6185.907211391743;6094.177286066324;6388.840278993062;6405.455536279282;6407.615543067431;6412.775552855627;6205.751769929152;6222.937770622236;6223.128761973418;6224.128621992834;6227.719752611234;6343.746250149942;6358.936410635834;6362.491000720024;6368.299487056513;6374.649394283173;5943.138244954544;6013.278406591237;6219.067139929047;6225.688715564294;6239.282482514569 06:03:00 INFO - PROCESS | 8809 | |5;yui.html;667.3926726678724;691.1567887177641;726.5059759363634;731.2943009995354;767.0923335365038;14080.577582672524;14216.573502794907;14239.71520569588;14263.786043209348;14289.142651440894;12502.624921252354;12739.299338536377;13388.062835601511;13546.593602191926;13550.254735989542;662.4369286106819;815.759350991456;819.8811172379986;834.837206744685;842.473454091193;839.588601585225;841.8316336732647;841.8905542279496;842.0695131879277;842.0821304777791;884.305819931354;884.8628462588309;885.716570697377;886.0740526150156;886.3219636977717;703.1281211297979;860.4020205956863;874.3442418186361;874.8031692869054;880.4497189256715;644.4908522267403;644.735658380062;645.122633218822;645.33852800879;645.644895307579;13779.586612401645;13827.585172444842;13846.030777845555;13856.515021974183;13862.168269903737;11906.1070419718;12064.09519286057;12487.188332758433;12607.243565386107;12638.431270592846;9816.558254878548;9878.110970012733;9965.20278377728;10149.39103653783;10338.689839304832;3387;3417.96582034179;3418.5555877735737;3492.528508651325;3508.6842184203288;46239.76880115612;46579.53420465786;46920.29619555709;47047.52952470466;47304.086989126015;8893.599788009555;9088.136627020422;9185.173334399802;9232.769180770534;9283.11810378013;17936.641267174844;18126;18147.18337674808;18153.45695615861;18393.54016149607;6371.52213583983;6371.55399122057;6537.477001839841;7387.076615423072;7587.127480339721;4108.5275193353145;4141.254574176617;4209.915801683949;4235.53409124996;4319.805608747551;3092.9072127835752;3097.4424603571574;3112.797668151563;3132.545780861762;3148.449021421242;513.9460356662571;525.836990532936;526.5787370103978;526.7234701781518;527.2644660698304;490.8380234522599;580.7764010855766;585.3268740947944;622.483338828771;625.8967270400424;7925.167857375008;7982.68069277234;8185.263326300662;8203;8293.253607175384;546.2557686492744;610.0970563565947;615.9476444502268;627.3162253144095;656.5830697507117;3671.3391589514144;3741.420079887622;3841.750286231386;3857.209272099269;3862.4743226425967;53121.2031819523;53659;53903.730481347346;57878.7106064467;59403.108953365736;44960.550394495636;45035.774821125684;45205.32192017123;45654.54345456569;48007;45057.098858022655;45797;45892.54107458883;46374;46766.76616616895;8179.713710020121;8187.345012399113;8369.539675317916;8438.873416898874;8470.237678608955;34509;34763.478547821294;35361.82319088388;35707;35733.64266357303;41852.58147418609;41861;44532.55467445284;45041.54958450505;45532.77233613811;10586.788264234518;10610.787784244118;10632;11098.50056747432;11190.83213751778;11197.832032519356;11453.48459319316;11525.193236473366;11775.175737698279;11901.285922844658;10637;10699.251052426567;10840.403777791982;10864.945675271572;11085.168612353944;10574.682759517227;10635.574577016832;10866.836997444887;10913.454327283764;10943.781124377309;10521.316114452537;10859.565617375532;10927.125829933428;10943.83584246253;11227.55089796399;9440.150386465251;9473.100055494717;9545.623928651446;9746.658866939622;9790.902090979;8843.248323892542;8874.423162494417;8878.778030549289;9539.945523152493;9543.42739435636 06:03:00 INFO - PROCESS | 8809 | __end_tp_report 06:03:00 INFO - PROCESS | 8809 | __start_cc_report 06:03:00 INFO - PROCESS | 8809 | _x_x_mozilla_cycle_collect,790 06:03:00 INFO - PROCESS | 8809 | __end_cc_report 06:03:00 INFO - PROCESS | 8809 | __startTimestamp1457445780839__endTimestamp 06:03:00 INFO - PROCESS | 8809 | 06:03:00 INFO - PROCESS | 8809 | ------- Summary: start ------- 06:03:00 INFO - PROCESS | 8809 | Number of tests: 6 06:03:00 INFO - PROCESS | 8809 | 06:03:00 INFO - PROCESS | 8809 | [#0] dojo.html Cycles:165 Average:5137.36 Median:5335.25 stddev:570.09 (10.7%) stddev-sans-first:546.22 06:03:00 INFO - PROCESS | 8809 | Values: 2983.6 3020.9 3031.6 3043.0 3066.8 4989.6 5157.8 5158.3 5174.8 5210.4 5088.4 5114.9 5153.1 5168.2 5196.0 4622.6 4671.1 4707.7 4761.7 4876.8 4821.8 4824.2 4851.8 4878.3 4879.6 4612.5 4716.7 4747.9 4782.2 4792.9 4706.0 4706.2 4706.8 4723.8 4745.3 4578.3 4678.3 4689.7 4703.2 4748.1 5012.1 5083.1 5089.1 5093.2 5101.8 5522.5 5530.0 5540.3 5545.9 5548.7 5360.1 5576.9 5586.5 5593.1 5596.3 5165.3 5197.9 5206.3 5230.5 5252.1 5631.7 5633.2 5635.2 5639.5 5659.5 5339.7 5419.4 5428.4 5434.4 5447.2 5478.4 5491.2 5498.2 5508.1 5548.3 5452.1 5458.1 5463.0 5463.7 5465.5 5361.9 5467.3 5474.2 5508.5 5513.1 4266.2 4273.9 4282.1 4284.3 4319.0 3758.9 3794.5 3796.9 3816.3 3831.6 5105.3 5144.1 5222.6 5255.7 5301.9 5534.8 5545.1 5558.2 5567.5 5579.5 5253.6 5259.7 5262.9 5274.5 5304.8 4622.2 4715.6 4730.1 4746.2 4753.9 5758.5 5770.9 5777.2 5778.9 5787.6 5479.0 5480.5 5487.1 5493.7 5521.1 5582.3 5733.2 5733.8 5818.4 5839.1 5435.5 5493.8 5499.8 5504.2 5530.3 5335.3 5523.1 5528.4 5531.8 5578.8 5290.6 5340.9 5374.8 5408.9 5419.8 5403.3 5424.2 5430.5 5438.0 5440.5 5084.9 5330.4 5353.3 5357.9 5380.8 5384.0 5416.0 5419.5 5427.7 5472.9 5288.3 5298.2 5304.5 5305.5 5362.9 06:03:00 INFO - PROCESS | 8809 | 06:03:00 INFO - PROCESS | 8809 | [#1] ext.html Cycles:180 Average:46317.98 Median:33260.42 stddev:76745.65 (230.7%) stddev-sans-first:76883.88 06:03:00 INFO - PROCESS | 8809 | Values: 512.9 529.4 535.1 561.3 561.3 29086.0 37430.4 38158.6 38260.0 38302.6 40255.0 41029.8 41065.4 41082.2 41095.0 7408.9 8427.9 8653.6 8674.3 9943.6 9974.7 10124.2 10135.9 10139.7 10143.8 10159.1 10256.5 10270.5 10274.7 10284.7 10043.6 10143.9 10147.7 10150.1 10151.5 9997.6 10375.2 10418.8 10425.4 10430.5 40191.0 40534.4 40664.6 40705.0 40734.0 3095.8 3188.3 3211.6 3238.9 3299.3 30018.8 30601.5 30934.8 30951.6 31329.1 3559.8 3574.9 3592.8 3628.5 3647.6 291957.0 292239.0 293330.0 296483.0 297741.0 60393.4 60690.7 60755.4 60793.0 60801.7 67639.0 68607.0 68647.0 68730.3 68735.7 13975.4 13991.7 14021.6 14114.5 14127.9 10584.8 10597.2 10635.1 10639.9 10653.4 20068.5 20296.6 20304.9 20386.3 20399.7 7669.5 7791.1 7861.8 7917.9 7922.6 859.8 868.9 1012.3 1048.9 1068.7 28359.3 28582.9 28599.6 28796.4 28930.0 997.2 1051.9 1075.8 1085.4 1086.1 14321.2 14772.5 14861.9 15024.6 15136.9 352866.0 353241.0 353528.0 356503.0 357924.0 50730.5 51674.7 52020.7 52070.7 52421.5 1213.2 1238.9 1241.9 1317.7 1338.2 26912.6 28562.3 28840.9 29312.4 29393.3 43006.8 43218.6 43257.4 43274.8 43381.3 211352.0 211600.7 211677.0 211929.0 211935.0 30543.8 43453.8 43566.6 43998.8 44824.0 39733.6 39779.4 40744.8 41116.8 41156.2 35718.8 36532.3 37064.0 37155.6 37291.1 35957.8 36582.8 36745.0 36845.8 37412.4 34859.5 35091.6 35475.8 35660.0 35800.3 31849.7 32989.3 33036.5 33199.5 33321.3 25013.6 25388.5 25479.9 25672.4 25823.7 06:03:00 INFO - PROCESS | 8809 | 06:03:00 INFO - PROCESS | 8809 | [#2] jquery.html Cycles:180 Average:16549.67 Median:21176.34 stddev:26714.97 (126.2%) stddev-sans-first:26762.19 06:03:00 INFO - PROCESS | 8809 | Values: 341.1 348.6 351.3 358.3 362.4 16983.7 17095.0 17499.8 17673.9 17678.7 16982.8 16995.2 17159.4 17189.8 17216.8 5217.6 5226.9 5469.5 5471.6 5472.3 5367.5 5449.1 5454.6 5456.5 5457.8 5428.1 5430.9 5746.1 5986.1 5987.6 5967.4 5990.6 5993.4 6006.4 6045.5 5151.0 5254.6 5282.9 5300.4 5345.1 11923.9 12740.7 12755.4 12833.6 12835.3 1865.6 1944.8 1967.8 1991.2 2125.5 9384.7 9386.0 9408.3 10775.5 12351.8 1752.1 1769.2 1785.9 1793.6 1864.1 46501.8 48278.8 56946.4 61303.0 62762.4 9908.3 10121.6 10144.9 10198.5 10244.6 13383.2 13463.3 13482.6 13487.7 13496.0 6347.6 6537.8 7157.9 7435.5 7435.8 7264.8 7305.8 7393.4 7409.8 7475.7 4175.2 4176.9 4183.5 4246.9 4262.4 1814.2 1815.4 1816.8 1857.3 1866.8 858.9 909.4 978.6 994.9 1029.5 16159.3 16532.2 16655.6 16689.4 17176.3 865.7 892.5 894.1 894.5 923.6 9212.1 9486.0 9488.7 9612.3 9691.6 145256.0 146398.0 146985.0 147373.0 147711.0 68904.7 70555.0 72662.6 72970.6 74168.3 945.8 948.1 972.7 986.9 992.4 11869.4 14188.0 14607.9 14687.9 14963.5 31378.5 31742.0 32060.8 32611.5 32750.3 38177.4 42909.8 44565.8 44567.8 45294.0 7932.9 7993.9 8098.9 8174.4 8234.4 9205.5 12421.2 12534.0 12561.5 12594.7 10477.7 10586.2 10807.1 10828.1 11017.3 10563.7 10649.5 10650.5 10754.9 10774.5 10716.2 10843.5 10990.1 10997.5 11249.2 7872.7 7957.9 7987.5 8037.8 8182.8 8426.7 10061.2 10792.2 10809.4 10850.5 06:03:00 INFO - PROCESS | 8809 | 06:03:00 INFO - PROCESS | 8809 | [#3] mootools.html Cycles:180 Average:5509.72 Median:6031.23 stddev:2827.66 (46.9%) stddev-sans-first:2817.26 06:03:00 INFO - PROCESS | 8809 | Values: 1227.0 1465.1 1469.9 1634.3 1772.5 6948.6 7604.1 7743.7 7757.4 7759.7 7612.2 7796.1 7801.8 7803.1 7842.4 1993.1 2253.4 2310.7 2331.9 2355.5 2272.6 2284.3 2302.3 2313.3 2314.5 2249.2 2326.4 2328.0 2328.9 2330.2 2244.9 2262.2 2279.3 2293.4 2293.7 2300.9 2339.5 2339.7 2351.6 2362.9 7647.3 7697.5 7707.8 7712.4 7718.7 4792.7 4934.0 4936.6 4940.8 4942.5 3087.5 3167.0 3187.0 3219.4 3232.5 1063.9 1785.5 1805.3 1805.5 1817.8 10456.4 10589.9 10595.2 10611.4 10617.9 4327.3 4418.9 4456.9 4485.7 4511.1 9185.1 9187.7 9189.1 9190.4 9193.0 4293.8 4814.7 4828.6 4861.9 4868.4 4351.6 4439.2 4450.0 4467.6 4475.7 3757.0 3821.2 3823.7 3827.7 3885.0 1204.5 1210.2 1223.1 1225.2 1240.1 1282.5 1290.3 1292.4 1302.4 1316.1 7481.4 7585.7 7601.6 7607.4 7611.0 489.3 496.9 498.8 503.0 510.3 5801.2 5869.7 5884.2 5930.8 5943.6 9033.0 9524.2 9649.0 9672.0 9708.8 9528.0 9550.8 9557.6 9559.9 9638.1 7223.3 7542.8 7587.7 7590.4 7599.9 7112.6 7114.3 7144.1 7168.0 7174.9 8466.7 8629.2 8719.0 8739.2 8769.1 8684.2 8710.7 8783.1 8922.5 8934.8 5959.2 6103.3 6104.4 6582.1 6606.0 7273.5 7459.3 7467.9 7470.9 7482.0 6693.7 6835.5 6857.3 6938.8 6967.4 6713.5 6731.2 6801.3 6833.7 6843.9 6987.2 7010.0 7017.5 7024.2 7132.6 6609.0 6613.3 6657.0 6665.2 6684.4 6633.5 6672.5 6693.6 6697.0 6704.7 06:03:00 INFO - PROCESS | 8809 | 06:03:00 INFO - PROCESS | 8809 | [#4] prototype.html Cycles:180 Average:5257.34 Median:5996.12 stddev:1604.60 (26.8%) stddev-sans-first:1566.05 06:03:00 INFO - PROCESS | 8809 | Values: 338.4 342.3 343.9 345.6 355.5 5871.5 5892.6 5903.1 5935.6 5964.8 5867.7 5871.4 5874.1 5875.9 5879.9 4275.0 4409.6 4508.9 4561.1 4576.6 4492.6 4492.7 4526.4 4539.8 4549.5 4497.7 4540.3 4548.2 4550.2 4553.5 4294.7 4405.3 4510.4 4512.0 4522.4 3945.2 3945.3 3947.1 3952.7 3957.5 5632.4 5634.2 5635.7 5639.7 5640.7 5255.6 5264.8 5267.1 5268.9 5270.5 6249.8 6265.7 6271.3 6276.2 6276.4 4193.5 4337.7 4340.6 4385.2 4398.5 6477.7 6499.3 6541.0 6541.2 6549.3 4418.7 4421.7 4424.5 4424.7 4426.6 4477.7 4484.7 4488.3 4488.6 4489.0 5204.0 5215.2 5223.0 5226.7 5228.9 6082.0 6316.2 6318.0 6319.7 6324.7 1539.5 1541.9 1550.1 1551.3 1552.5 947.9 988.8 1002.6 1023.4 1032.3 5932.6 6010.3 6017.0 6019.3 6025.5 6417.8 6419.1 6427.1 6429.9 6437.7 5981.9 6016.2 6039.4 6051.3 6056.4 3412.6 3439.8 3447.6 3448.2 3452.6 6666.4 6779.9 6797.3 6850.6 6860.5 6640.6 6648.1 6664.2 6664.5 6681.9 6912.7 6914.7 6915.2 6917.4 6919.0 6493.4 6504.3 6510.8 6520.4 6520.8 6207.3 6398.8 6479.1 6484.6 6489.2 6836.4 6892.4 6908.7 6914.9 6927.0 4519.9 4523.7 4531.3 4531.5 4533.9 6390.3 6394.3 6409.7 6445.7 6449.1 6102.0 6158.6 6177.6 6180.5 6185.9 6094.2 6388.8 6405.5 6407.6 6412.8 6205.8 6222.9 6223.1 6224.1 6227.7 6343.7 6358.9 6362.5 6368.3 6374.6 5943.1 6013.3 6219.1 6225.7 6239.3 06:03:00 INFO - PROCESS | 8809 | 06:03:00 INFO - PROCESS | 8809 | [#5] yui.html Cycles:180 Average:13386.96 Median:46476.77 stddev:15371.75 (33.1%) stddev-sans-first:15385.19 06:03:00 INFO - PROCESS | 8809 | Values: 667.4 691.2 726.5 731.3 767.1 14080.6 14216.6 14239.7 14263.8 14289.1 12502.6 12739.3 13388.1 13546.6 13550.3 662.4 815.8 819.9 834.8 842.5 839.6 841.8 841.9 842.1 842.1 884.3 884.9 885.7 886.1 886.3 703.1 860.4 874.3 874.8 880.4 644.5 644.7 645.1 645.3 645.6 13779.6 13827.6 13846.0 13856.5 13862.2 11906.1 12064.1 12487.2 12607.2 12638.4 9816.6 9878.1 9965.2 10149.4 10338.7 3387.0 3418.0 3418.6 3492.5 3508.7 46239.8 46579.5 46920.3 47047.5 47304.1 8893.6 9088.1 9185.2 9232.8 9283.1 17936.6 18126.0 18147.2 18153.5 18393.5 6371.5 6371.6 6537.5 7387.1 7587.1 4108.5 4141.3 4209.9 4235.5 4319.8 3092.9 3097.4 3112.8 3132.5 3148.4 513.9 525.8 526.6 526.7 527.3 490.8 580.8 585.3 622.5 625.9 7925.2 7982.7 8185.3 8203.0 8293.3 546.3 610.1 615.9 627.3 656.6 3671.3 3741.4 3841.8 3857.2 3862.5 53121.2 53659.0 53903.7 57878.7 59403.1 44960.6 45035.8 45205.3 45654.5 48007.0 45057.1 45797.0 45892.5 46374.0 46766.8 8179.7 8187.3 8369.5 8438.9 8470.2 34509.0 34763.5 35361.8 35707.0 35733.6 41852.6 41861.0 44532.6 45041.5 45532.8 10586.8 10610.8 10632.0 11098.5 11190.8 11197.8 11453.5 11525.2 11775.2 11901.3 10637.0 10699.3 10840.4 10864.9 11085.2 10574.7 10635.6 10866.8 10913.5 10943.8 10521.3 10859.6 10927.1 10943.8 11227.6 9440.2 9473.1 9545.6 9746.7 9790.9 8843.2 8874.4 8878.8 9539.9 9543.4 06:03:00 INFO - PROCESS | 8809 | -------- Summary: end -------- 06:03:00 INFO - PROCESS | 8809 | 06:03:01 INFO - TEST-INFO | 8809: exit 0 06:03:01 INFO - TEST-OK | dromaeo_css | took 1112640ms 06:03:01 INFO - TEST-START | kraken 06:03:01 INFO - operating with platform_type : linux_ 06:03:01 INFO - Initialising browser for kraken test... 06:03:01 INFO - TEST-INFO | started process 8992 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBWk7lo/profile http://localhost:48296/getInfo.html) 06:03:05 INFO - PROCESS | 8992 | __metrics Screen width/height:1600/1200 06:03:05 INFO - PROCESS | 8992 | colorDepth:24 06:03:05 INFO - PROCESS | 8992 | Browser inner width/height: 1024/697 06:03:05 INFO - PROCESS | 8992 | __metrics 06:03:06 INFO - PROCESS | 8992 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:03:06 INFO - PROCESS | 8992 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 06:03:07 INFO - TEST-INFO | 8992: exit 0 06:03:07 INFO - Browser initialized. 06:03:07 INFO - Running cycle 1/1 for kraken test... 06:03:07 INFO - TEST-INFO | started process 9078 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBWk7lo/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:03:19 INFO - PROCESS | 9078 | RSS: Main: 156655616 06:03:19 INFO - PROCESS | 9078 | 06:03:21 INFO - PROCESS | 9078 | Cycle 1(1): loaded http://localhost:48296/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48296/tests/kraken/driver.html?testName=audio-beat-detection) 06:03:22 INFO - PROCESS | 9078 | RSS: Main: 199065600 06:03:22 INFO - PROCESS | 9078 | 06:03:25 INFO - PROCESS | 9078 | Cycle 1(1): loaded http://localhost:48296/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48296/tests/kraken/driver.html?testName=audio-dft) 06:03:25 INFO - PROCESS | 9078 | RSS: Main: 189763584 06:03:25 INFO - PROCESS | 9078 | 06:03:28 INFO - PROCESS | 9078 | Cycle 1(1): loaded http://localhost:48296/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48296/tests/kraken/driver.html?testName=audio-fft) 06:03:29 INFO - PROCESS | 9078 | RSS: Main: 171704320 06:03:29 INFO - PROCESS | 9078 | 06:03:31 INFO - PROCESS | 9078 | Cycle 1(1): loaded http://localhost:48296/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48296/tests/kraken/driver.html?testName=audio-oscillator) 06:03:31 INFO - PROCESS | 9078 | RSS: Main: 173752320 06:03:31 INFO - PROCESS | 9078 | 06:03:34 INFO - PROCESS | 9078 | Cycle 1(1): loaded http://localhost:48296/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48296/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:03:34 INFO - PROCESS | 9078 | RSS: Main: 175484928 06:03:34 INFO - PROCESS | 9078 | 06:03:37 INFO - PROCESS | 9078 | Cycle 1(1): loaded http://localhost:48296/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48296/tests/kraken/driver.html?testName=imaging-darkroom) 06:03:38 INFO - PROCESS | 9078 | RSS: Main: 176062464 06:03:38 INFO - PROCESS | 9078 | 06:03:41 INFO - PROCESS | 9078 | Cycle 1(1): loaded http://localhost:48296/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48296/tests/kraken/driver.html?testName=imaging-desaturate) 06:03:42 INFO - PROCESS | 9078 | RSS: Main: 177725440 06:03:42 INFO - PROCESS | 9078 | 06:03:45 INFO - PROCESS | 9078 | Cycle 1(1): loaded http://localhost:48296/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48296/tests/kraken/driver.html?testName=json-parse-financial) 06:03:45 INFO - PROCESS | 9078 | RSS: Main: 177827840 06:03:45 INFO - PROCESS | 9078 | 06:03:47 INFO - PROCESS | 9078 | Cycle 1(1): loaded http://localhost:48296/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48296/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:03:47 INFO - PROCESS | 9078 | RSS: Main: 187584512 06:03:47 INFO - PROCESS | 9078 | 06:03:49 INFO - PROCESS | 9078 | Cycle 1(1): loaded http://localhost:48296/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48296/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:03:50 INFO - PROCESS | 9078 | RSS: Main: 187113472 06:03:50 INFO - PROCESS | 9078 | 06:03:52 INFO - PROCESS | 9078 | Cycle 1(1): loaded http://localhost:48296/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48296/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:03:52 INFO - PROCESS | 9078 | RSS: Main: 199192576 06:03:52 INFO - PROCESS | 9078 | 06:03:55 INFO - PROCESS | 9078 | Cycle 1(1): loaded http://localhost:48296/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48296/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:03:55 INFO - PROCESS | 9078 | RSS: Main: 203132928 06:03:55 INFO - PROCESS | 9078 | 06:03:58 INFO - PROCESS | 9078 | Cycle 1(1): loaded http://localhost:48296/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48296/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:03:58 INFO - PROCESS | 9078 | RSS: Main: 203239424 06:03:58 INFO - PROCESS | 9078 | 06:04:00 INFO - PROCESS | 9078 | Cycle 1(1): loaded http://localhost:48296/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48296/tests/kraken/driver.html?testName=ai-astar) 06:04:00 INFO - PROCESS | 9078 | RSS: Main: 262750208 06:04:00 INFO - PROCESS | 9078 | 06:04:00 INFO - PROCESS | 9078 | __start_tp_report 06:04:00 INFO - PROCESS | 9078 | _x_x_mozilla_page_load 06:04:00 INFO - PROCESS | 9078 | _x_x_mozilla_page_load_details 06:04:00 INFO - PROCESS | 9078 | |i|pagename|runs| 06:04:00 INFO - PROCESS | 9078 | |0;ai-astar;112;112;104;111;112;113;99;114;112;109 06:04:00 INFO - PROCESS | 9078 | |1;audio-beat-detection;158;127;150;167;129;159;160;128;176;126 06:04:00 INFO - PROCESS | 9078 | |2;audio-dft;161;160;163;163;161;162;162;164;165;166 06:04:00 INFO - PROCESS | 9078 | |3;audio-fft;76;76;104;96;74;76;73;120;91;76 06:04:00 INFO - PROCESS | 9078 | |4;audio-oscillator;94;93;149;93;94;93;136;94;94;137 06:04:00 INFO - PROCESS | 9078 | |5;imaging-gaussian-blur;117;117;116;117;116;116;117;117;117;117 06:04:00 INFO - PROCESS | 9078 | |6;imaging-darkroom;145;145;145;145;145;145;145;145;145;146 06:04:00 INFO - PROCESS | 9078 | |7;imaging-desaturate;96;96;95;96;95;95;96;95;95;95 06:04:00 INFO - PROCESS | 9078 | |8;json-parse-financial;57;60;57;56;57;57;57;65;56;55 06:04:00 INFO - PROCESS | 9078 | |9;json-stringify-tinderbox;68;69;69;69;68;70;69;68;69;69 06:04:00 INFO - PROCESS | 9078 | |10;stanford-crypto-aes;79;81;81;80;81;81;80;81;80;81 06:04:00 INFO - PROCESS | 9078 | |11;stanford-crypto-ccm;113;118;115;112;111;122;115;120;113;123 06:04:00 INFO - PROCESS | 9078 | |12;stanford-crypto-pbkdf2;139;129;144;142;143;133;139;136;139;139 06:04:00 INFO - PROCESS | 9078 | |13;stanford-crypto-sha256-iterative;72;69;67;67;69;67;67;68;67;66 06:04:00 INFO - PROCESS | 9078 | __end_tp_report 06:04:00 INFO - PROCESS | 9078 | __start_cc_report 06:04:00 INFO - PROCESS | 9078 | _x_x_mozilla_cycle_collect,1108 06:04:00 INFO - PROCESS | 9078 | __end_cc_report 06:04:00 INFO - PROCESS | 9078 | __startTimestamp1457445840920__endTimestamp 06:04:00 INFO - PROCESS | 9078 | 06:04:00 INFO - PROCESS | 9078 | ------- Summary: start ------- 06:04:00 INFO - PROCESS | 9078 | Number of tests: 14 06:04:00 INFO - PROCESS | 9078 | 06:04:00 INFO - PROCESS | 9078 | [#0] ai-astar Cycles:10 Average:109.80 Median:112.00 stddev:4.71 (4.2%) stddev-sans-first:4.93 06:04:00 INFO - PROCESS | 9078 | Values: 112.0 112.0 104.0 111.0 112.0 113.0 99.0 114.0 112.0 109.0 06:04:00 INFO - PROCESS | 9078 | 06:04:00 INFO - PROCESS | 9078 | [#1] audio-beat-detection Cycles:10 Average:148.00 Median:158.50 stddev:18.86 (11.9%) stddev-sans-first:19.65 06:04:00 INFO - PROCESS | 9078 | Values: 158.0 127.0 150.0 167.0 129.0 159.0 160.0 128.0 176.0 126.0 06:04:00 INFO - PROCESS | 9078 | 06:04:00 INFO - PROCESS | 9078 | [#2] audio-dft Cycles:10 Average:162.70 Median:163.00 stddev:1.89 (1.2%) stddev-sans-first:1.90 06:04:00 INFO - PROCESS | 9078 | Values: 161.0 160.0 163.0 163.0 161.0 162.0 162.0 164.0 165.0 166.0 06:04:00 INFO - PROCESS | 9078 | 06:04:00 INFO - PROCESS | 9078 | [#3] audio-fft Cycles:10 Average:86.20 Median:76.00 stddev:16.05 (21.1%) stddev-sans-first:16.59 06:04:00 INFO - PROCESS | 9078 | Values: 76.0 76.0 104.0 96.0 74.0 76.0 73.0 120.0 91.0 76.0 06:04:00 INFO - PROCESS | 9078 | 06:04:00 INFO - PROCESS | 9078 | [#4] audio-oscillator Cycles:10 Average:107.70 Median:93.50 stddev:23.01 (24.6%) stddev-sans-first:23.86 06:04:00 INFO - PROCESS | 9078 | Values: 94.0 93.0 149.0 93.0 94.0 93.0 136.0 94.0 94.0 137.0 06:04:00 INFO - PROCESS | 9078 | 06:04:00 INFO - PROCESS | 9078 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 06:04:00 INFO - PROCESS | 9078 | Values: 117.0 117.0 116.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 06:04:00 INFO - PROCESS | 9078 | 06:04:00 INFO - PROCESS | 9078 | [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 06:04:00 INFO - PROCESS | 9078 | Values: 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 146.0 06:04:00 INFO - PROCESS | 9078 | 06:04:00 INFO - PROCESS | 9078 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 06:04:00 INFO - PROCESS | 9078 | Values: 96.0 96.0 95.0 96.0 95.0 95.0 96.0 95.0 95.0 95.0 06:04:00 INFO - PROCESS | 9078 | 06:04:00 INFO - PROCESS | 9078 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:57.00 stddev:2.87 (5.0%) stddev-sans-first:3.03 06:04:00 INFO - PROCESS | 9078 | Values: 57.0 60.0 57.0 56.0 57.0 57.0 57.0 65.0 56.0 55.0 06:04:00 INFO - PROCESS | 9078 | 06:04:00 INFO - PROCESS | 9078 | [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:69.00 stddev:0.63 (0.9%) stddev-sans-first:0.60 06:04:00 INFO - PROCESS | 9078 | Values: 68.0 69.0 69.0 69.0 68.0 70.0 69.0 68.0 69.0 69.0 06:04:00 INFO - PROCESS | 9078 | 06:04:00 INFO - PROCESS | 9078 | [#10] stanford-crypto-aes Cycles:10 Average:80.50 Median:81.00 stddev:0.71 (0.9%) stddev-sans-first:0.50 06:04:00 INFO - PROCESS | 9078 | Values: 79.0 81.0 81.0 80.0 81.0 81.0 80.0 81.0 80.0 81.0 06:04:00 INFO - PROCESS | 9078 | 06:04:00 INFO - PROCESS | 9078 | [#11] stanford-crypto-ccm Cycles:10 Average:116.20 Median:116.50 stddev:4.29 (3.7%) stddev-sans-first:4.39 06:04:00 INFO - PROCESS | 9078 | Values: 113.0 118.0 115.0 112.0 111.0 122.0 115.0 120.0 113.0 123.0 06:04:00 INFO - PROCESS | 9078 | 06:04:00 INFO - PROCESS | 9078 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.30 Median:139.00 stddev:4.60 (3.3%) stddev-sans-first:4.87 06:04:00 INFO - PROCESS | 9078 | Values: 139.0 129.0 144.0 142.0 143.0 133.0 139.0 136.0 139.0 139.0 06:04:00 INFO - PROCESS | 9078 | 06:04:00 INFO - PROCESS | 9078 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:67.50 stddev:1.73 (2.6%) stddev-sans-first:1.01 06:04:00 INFO - PROCESS | 9078 | Values: 72.0 69.0 67.0 67.0 69.0 67.0 67.0 68.0 67.0 66.0 06:04:00 INFO - PROCESS | 9078 | -------- Summary: end -------- 06:04:00 INFO - PROCESS | 9078 | 06:04:01 INFO - TEST-INFO | 9078: exit 0 06:04:01 INFO - TEST-OK | kraken | took 60405ms 06:04:01 INFO - SUITE-END | took 1173s 06:04:02 INFO - Completed test suite (00:19:33) 06:04:02 INFO - javascript benchmark 06:04:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2983.627046619173, 3020.8640611172495, 3031.6362036555615, 3043.0414419457857, 3066.8006579572325, 4989.575886049681, 5157.845264642062, 5158.277841102249, 5174.844754657357, 5210.426853046167, 5088.440271570124, 5114.872128196787, 5153.149730294497, 5168.173092305232, 5196.0, 4622.6070783983405, 4671.135839869627, 4707.693999890013, 4761.6904901181315, 4876.804927802884, 4821.807127714905, 4824.2040063389495, 4851.805927762903, 4878.268259761029, 4879.634027447938, 4612.492625811158, 4716.740579268156, 4747.881302967419, 4782.1631214537665, 4792.856214313576, 4705.952940470585, 4706.247000479907, 4706.78819453122, 4723.834665786681, 4745.311929770164, 4578.336141259499, 4678.345031695565, 4689.718616882998, 4703.2474804031535, 4748.121597504472, 5012.072766538202, 5083.05963396769, 5089.109405853961, 5093.236014597803, 5101.82143624975, 5522.502974732293, 5529.972350138223, 5540.279763630702, 5545.889082218373, 5548.6948217848, 5360.115580929181, 5576.944230557683, 5586.497215250647, 5593.077142271521, 5596.272484576979, 5165.328507294028, 5197.922031169535, 5206.3492063491685, 5230.476952304777, 5252.080885844962, 5631.662100273997, 5633.155026746021, 5635.1828984796975, 5639.492445679908, 5659.462351076641, 5339.652922560022, 5419.376771671308, 5428.4028756836715, 5434.402215756264, 5447.210154527571, 5478.397376288605, 5491.2312276281355, 5498.230247765316, 5508.118701007819, 5548.250986116904, 5452.127659574449, 5458.0721277382145, 5463.043967305785, 5463.726813659301, 5465.453454654582, 5361.865953351197, 5467.289252397242, 5474.178873169057, 5508.476694713996, 5513.145462453326, 4266.189424009491, 4273.914521709548, 4282.07935293907, 4284.250256205151, 4318.956810431919, 3758.9060273493383, 3794.5446546414605, 3796.924061518754, 3816.3321418751607, 3831.63599458051, 5105.310783044316, 5144.074066668036, 5222.608304377187, 5255.710935898486, 5301.893962120813, 5534.75093620788, 5545.140503222007, 5558.166275058774, 5567.47109024642, 5579.46995035471, 5253.579713622978, 5259.684418934799, 5262.947370526245, 5274.498922602346, 5304.787808487695, 4622.19111655459, 4715.552022557851, 4730.101280756645, 4746.2168742157155, 4753.857384278477, 5758.452946970031, 5770.855728606818, 5777.220075289866, 5778.884422311614, 5787.594868359174, 5479.013777520085, 5480.479354461399, 5487.094629386106, 5493.697846618475, 5521.116621340727, 5582.302212223472, 5733.2260144881575, 5733.799317023884, 5818.418158184148, 5839.065749480233, 5435.483629055233, 5493.7802487900035, 5499.752511136929, 5504.2018907257425, 5530.308711411074, 5335.253064570886, 5523.061079616556, 5528.364238112668, 5531.751071201725, 5578.832635020955, 5290.629655924048, 5340.946590534045, 5374.758135883816, 5408.891822163456, 5419.783208671766, 5403.324584426947, 5424.2134890439875, 5430.484104010113, 5438.0, 5440.483154100354, 5084.949150508448, 5330.440303768049, 5353.2505449237915, 5357.946420535744, 5380.811671591476, 5384.0, 5415.972920135374, 5419.539339156216, 5427.728613569227, 5472.863178420572, 5288.259643649815, 5298.231756395224, 5304.496072873071, 5305.522502974751, 5362.865928351823], "unit": "score", "name": "dojo.html", "value": 5099.899682377617}, {"lowerIsBetter": false, "replicates": [512.9128048231801, 529.4097081753846, 535.0663092902884, 561.2843624378917, 561.2899681902392, 29086.0, 37430.43854342187, 38158.61841381586, 38260.0, 38302.616973830256, 40255.0, 41029.79485102578, 41065.38401923973, 41082.17835643285, 41095.0, 7408.888866667005, 8427.873581896261, 8653.610587523544, 8674.349423793241, 9943.602255909791, 9974.650887218948, 10124.190064794799, 10135.898641013606, 10139.695809125702, 10143.847842282372, 10159.13647339977, 10256.487175641225, 10270.486475676224, 10274.691759247235, 10284.742881427987, 10043.598256069748, 10143.89856101437, 10147.746306342327, 10150.137238334713, 10151.492425378776, 9997.600095996151, 10375.221858360654, 10418.801837788675, 10425.426601536912, 10430.478476076165, 40191.0, 40534.39198412026, 40664.593354066375, 40705.0, 40734.0, 3095.829729364884, 3188.2985743136474, 3211.5824942757527, 3238.870405576685, 3299.290652509698, 30018.849905750332, 30601.540976885364, 30934.845325773225, 30951.597955096007, 31329.06012819619, 3559.7624165291027, 3574.857005719768, 3592.8383222755037, 3628.4920111184456, 3647.5622925248877, 291957.0, 292239.0, 293330.0, 296483.0, 297741.0, 60393.396066039655, 60690.696546517865, 60755.39244607498, 60793.0, 60801.695991520646, 67639.0, 68607.0, 68647.0, 68730.31269687338, 68735.65632171807, 13975.37110830015, 13991.720165596631, 14021.649458763612, 14114.50599229022, 14127.858721412655, 10584.841227381596, 10597.152227821756, 10635.149188064936, 10639.946800265949, 10653.360798352123, 20068.498287542927, 20296.594068118557, 20304.898475507824, 20386.286479973427, 20399.694004589943, 7669.501482403626, 7791.142974272825, 7861.803454913558, 7917.881231781528, 7922.564258965697, 859.8027395094178, 868.8957325121025, 1012.2509343086064, 1048.8777008600875, 1068.7435015596202, 28359.29101772431, 28582.857085714855, 28599.57100643492, 28796.424071518453, 28929.987450439556, 997.152420442618, 1051.9217801753264, 1075.774087441646, 1085.375908852413, 1086.1419478611808, 14321.212333321559, 14772.48296309624, 14861.851381486264, 15024.62438439026, 15136.924315378574, 352866.0, 353241.0, 353528.0, 356503.0, 357924.0, 50730.49269507331, 51674.74162629163, 52020.73989630028, 52070.739646301525, 52421.47578524242, 1213.205350495427, 1238.8637249902504, 1241.8944389726973, 1317.736452709462, 1338.2171429713726, 26912.596311055742, 28562.285942851595, 28840.855795720887, 29312.41375172442, 29393.265168370963, 43006.78496607622, 43218.56781432145, 43257.3511397323, 43274.78362608167, 43381.34927976146, 211352.0, 211600.70998225166, 211677.0, 211929.0, 211935.0, 30543.847280763453, 43453.78273108614, 43566.56433435625, 43998.78000609976, 44824.0, 39733.60266397415, 39779.40330895097, 40744.79627601843, 41116.794416027726, 41156.1768764617, 35718.821405892806, 36532.269354613294, 37064.0, 37155.62844371521, 37291.06772330605, 35957.820210898775, 36582.8170859144, 36745.0, 36845.81577092098, 37412.43881341728, 34859.4771078429, 35091.64908350986, 35475.82262088673, 35660.0, 35800.28399431945, 31849.68150318467, 32989.34021319608, 33036.50445243275, 33199.50200747039, 33321.333573328884, 25013.624795628442, 25388.49223015566, 25479.872600636878, 25672.358191045372, 25823.741762582133], "unit": "score", "name": "ext.html", "value": 18654.957497331245}, {"lowerIsBetter": false, "replicates": [341.1301181985936, 348.5851836314785, 351.2886405029816, 358.31740534282204, 362.3550080856077, 16983.745243821337, 17095.0, 17499.825001749963, 17673.91163044186, 17678.734818977693, 16982.83017169828, 16995.15024248789, 17159.399421020265, 17189.82810171898, 17216.82783172168, 5217.58259339252, 5226.895462090765, 5469.535089517396, 5471.5896307776875, 5472.26124473197, 5367.543758780489, 5449.100898351767, 5454.645448045884, 5456.508914197721, 5457.754401051942, 5428.077226871442, 5430.864228394283, 5746.051901436258, 5986.132010858423, 5987.580869339148, 5967.40325967402, 5990.580659353847, 5993.370696076914, 6006.369331220247, 6045.486133678643, 5150.97424512875, 5254.605904557174, 5282.920756188661, 5300.3639563252655, 5345.064613692588, 11923.94038029813, 12740.745185096339, 12755.362231888368, 12833.550825721055, 12835.294058826761, 1865.6082222733241, 1944.824965753089, 1967.8130577595105, 1991.2035185925602, 2125.4792575819024, 9384.718458446258, 9385.953070234606, 9408.341416100875, 10775.515101820436, 12351.814722779165, 1752.1151818331662, 1769.2038582637865, 1785.874988750788, 1793.5874748807848, 1864.0586503815487, 46501.767491162325, 48278.7586062071, 56946.430535694526, 61303.0, 62762.37237627611, 9908.306418550776, 10121.645742398981, 10144.898551014396, 10198.541065652063, 10244.59021639141, 13383.19700817954, 13463.326833658279, 13482.595522134352, 13487.730245395038, 13496.0, 6347.630065839839, 6537.771178008747, 7157.856842863113, 7435.4795164337975, 7435.776926692208, 7264.782056538313, 7305.780826575211, 7393.3527199949285, 7409.777706668809, 7475.70097196117, 4175.248455278019, 4176.916461670749, 4183.477065366829, 4246.936295955563, 4262.424572682648, 1814.1926842554935, 1815.4009176971567, 1816.8470362620337, 1857.3035111833062, 1866.766654168229, 858.9484630922165, 909.3589019741066, 978.6379039755194, 994.8708216174693, 1029.53156313877, 16159.272832722556, 16532.173391330387, 16655.583610409838, 16689.415870444718, 17176.31294748221, 865.7402779166225, 892.4823602310644, 894.065701342099, 894.5035505294624, 923.6259314977444, 9212.130905019907, 9486.0, 9488.667896623723, 9612.279079068958, 9691.612335506641, 145256.0, 146398.0, 146985.0, 147373.0, 147711.0, 68904.6554767223, 70555.0, 72662.63668681729, 72970.63514682393, 74168.25831741614, 945.7824700318828, 948.0756262644005, 972.7179118055684, 986.9407835529892, 992.4392718114242, 11869.406529673655, 14188.0, 14607.92696036513, 14687.92656036713, 14963.476278330207, 31378.52932205973, 31742.0, 32060.839695801373, 32611.510827338083, 32750.34499310048, 38177.427338590496, 42909.785451072545, 44565.777171113936, 44567.77716111398, 45294.0, 7932.920670793449, 7993.92006079955, 8098.919010809816, 8174.427790054639, 8234.423590348619, 9205.493697846683, 12421.192622479872, 12534.0, 12561.497540098293, 12594.685132871751, 10477.738056548647, 10586.153107751208, 10807.135429165804, 10828.133749300194, 11017.338959662125, 10563.683089507327, 10649.520771565143, 10650.520726567169, 10754.89245107539, 10774.511415661513, 10716.196285278791, 10843.45782710877, 10990.065844403316, 10997.450127493754, 11249.156313276373, 7872.685092596232, 7957.880631790644, 7987.482378348095, 8037.799055023671, 8182.7545173644885, 8426.662933482592, 10061.245406594388, 10792.190585705946, 10809.35143891369, 10850.45747712627], "unit": "score", "name": "jquery.html", "value": 7894.762547483491}, {"lowerIsBetter": false, "replicates": [1227.0183852917664, 1465.0770014890618, 1469.8750606198473, 1634.3380930723054, 1772.530279475939, 6948.583085014896, 7604.125525564562, 7743.728969486069, 7757.418193635472, 7759.689612415511, 7612.238776122385, 7796.142424333319, 7801.804954876131, 7803.06363236411, 7842.372610191185, 1993.1130646862152, 2253.3690566641367, 2310.688057112285, 2331.9183828566, 2355.5053438777877, 2272.579572779041, 2284.303287497321, 2302.343832007878, 2313.2597568777996, 2314.5486630107134, 2249.167807911075, 2326.3718795925174, 2328.0, 2328.8951997160084, 2330.207729372013, 2244.921427750029, 2262.1856131792542, 2279.259240746764, 2293.392251053472, 2293.7247530296304, 2300.861948283108, 2339.4502291961376, 2339.7426283108844, 2351.58847201739, 2362.8582285062953, 7647.311741943252, 7697.538147711155, 7707.845843083163, 7712.421568382394, 7718.6912523498995, 4792.688475249098, 4934.037862616791, 4936.555709986119, 4940.752962351868, 4942.456329803718, 3087.505999040143, 3167.0, 3187.0438868339406, 3219.356128774231, 3232.531282963957, 1063.8989296016866, 1785.5357607022138, 1805.3049575913237, 1805.5486128467883, 1817.818218178185, 10456.424896630682, 10589.894101058968, 10595.205359598061, 10611.363318200933, 10617.946910265398, 4327.32926396409, 4418.889527761768, 4456.888577785581, 4485.6860019798305, 4511.075229577928, 9185.127412895765, 9187.724368268962, 9189.127032931861, 9190.40262382943, 9193.0, 4293.763842988666, 4814.735189564538, 4828.565429111397, 4861.927071093936, 4868.391451068616, 4351.6301114405, 4439.178751930838, 4450.043240703199, 4467.553244675506, 4475.731456112644, 3756.9624303756614, 3821.2357528494413, 3823.6941044716355, 3827.6746476549806, 3885.0287428142965, 1204.5302332090491, 1210.1649861595472, 1223.113242898909, 1225.2158618484177, 1240.0823390690823, 1282.499825068224, 1290.2645492069619, 1292.373198998485, 1302.3813688498078, 1316.1379296560767, 7481.364084052916, 7585.6965721371635, 7601.619919004028, 7607.35337496308, 7611.048618922635, 489.3418352316129, 496.9304297398367, 498.81793145502354, 502.98742531437006, 510.2550276596137, 5801.216835727208, 5869.6771677558145, 5884.176215329857, 5930.792422265286, 5943.55423343251, 9032.954835225783, 9524.238060955107, 9648.98685638012, 9672.0, 9708.757281067888, 9528.0, 9550.761230969281, 9557.569909353957, 9559.904400955902, 9638.084381983701, 7223.349898509159, 7542.849143017109, 7587.748021576378, 7590.354819840375, 7599.924000760032, 7112.6088065154845, 7114.253003434772, 7144.142702875688, 7168.032315637531, 7174.928250717426, 8466.661333546836, 8629.223369896488, 8719.040905500517, 8739.21347078766, 8769.12308769118, 8684.2184203422, 8710.651573936972, 8783.077776833341, 8922.509261990654, 8934.821303574023, 5959.195508606283, 6103.267607887082, 6104.359042300672, 6582.144321238208, 6606.0, 7273.490855640054, 7459.254074592497, 7467.887981680387, 7470.887936680845, 7482.0, 6693.698783554654, 6835.487338449736, 6857.314268573103, 6938.826529336807, 6967.372936435745, 6713.530052896251, 6731.158605174353, 6801.319868013357, 6833.69248383814, 6843.8973415399805, 6987.161540615159, 7010.0, 7017.543859649107, 7024.1571011478945, 7132.643367831692, 6608.966955165193, 6613.338666133348, 6657.0, 6665.200175978914, 6684.4318232950745, 6633.469322454095, 6672.466202703869, 6693.598384096775, 6697.0, 6704.66476676174], "unit": "score", "name": "mootools.html", "value": 4507.3995956661465}, {"lowerIsBetter": false, "replicates": [338.3976521791211, 342.2726705750281, 343.94840773883914, 345.64053384480144, 355.4756733817619, 5871.471567558919, 5892.55805814564, 5903.085021821619, 5935.584509084366, 5964.761409543613, 5867.7066146692605, 5871.383504732005, 5874.148248503964, 5875.88248235035, 5879.8530036749, 4275.0, 4409.603135717784, 4508.909821803562, 4561.1105834362315, 4576.61098806601, 4492.573205545468, 4492.707973981697, 4526.366308716782, 4539.818407263706, 4549.545045495457, 4497.70764900282, 4540.250858608326, 4548.204064288753, 4550.203714349992, 4553.4991150973365, 4294.67789915756, 4405.273129933557, 4510.436195475566, 4511.954880451186, 4522.4346956630425, 3945.1517923646265, 3945.250402423559, 3947.072437977073, 3952.664023558001, 3957.4657421248053, 5632.3804381518, 5634.183043458716, 5635.71821408932, 5639.71801409932, 5640.746166422521, 5255.553277971377, 5264.789408423659, 5267.130923397634, 5268.894622107537, 5270.4729527047375, 6249.781257656005, 6265.71804268809, 6271.34150914152, 6276.215473065867, 6276.403741644536, 4193.5387107418155, 4337.7180483268485, 4340.6093451589195, 4385.166818304512, 4398.450193725785, 6477.708503117371, 6499.252585952581, 6541.0, 6541.247756508015, 6549.34506549346, 4418.668599855024, 4421.690481666253, 4424.513303536608, 4424.6902716810155, 4426.601605855489, 4477.686561940698, 4484.686071974996, 4488.349189367524, 4488.573585509372, 4488.977555112204, 5204.0, 5215.217717342353, 5222.97388513055, 5226.660267082628, 5228.9477105229225, 6081.969590152109, 6316.210473690789, 6317.989121740591, 6319.684015799284, 6324.747010119636, 1539.5458339789789, 1541.9074855508704, 1550.0777037662572, 1551.2631500037392, 1552.4721594657644, 947.9383840050513, 988.8022395520925, 1002.5989604158395, 1023.4371095897376, 1032.3444612670858, 5932.644041357446, 6010.308814486302, 6017.037274036134, 6019.307779605314, 6025.487833534111, 6417.839554011187, 6419.101325814389, 6427.100205971168, 6429.871402571923, 6437.710303036374, 5981.940180598225, 6016.2479690038745, 6039.396060393926, 6051.273847138372, 6056.424639659225, 3412.5904891412692, 3439.793612383265, 3447.5690538682666, 3448.189675426273, 3452.5511683480986, 6666.366695163952, 6779.864402711918, 6797.320267973262, 6850.623215723083, 6860.485463590251, 6640.63476508787, 6648.1025061616065, 6664.166979127609, 6664.500162487833, 6681.933180668131, 6912.723491060402, 6914.654267286615, 6915.204751453547, 6917.446604271646, 6918.965405172942, 6493.40263894446, 6504.317046710027, 6510.804675859732, 6520.380563846427, 6520.804375868732, 6207.255129384323, 6398.840028999312, 6479.125318082187, 6484.643344616092, 6489.221293444817, 6836.350546698056, 6892.448604111759, 6908.689108990007, 6914.859048256982, 6927.0, 4519.932201016922, 4523.660725445539, 4531.274996000756, 4531.478879928851, 4533.909321813611, 6390.329015453311, 6394.328595497592, 6409.679516024274, 6445.677716114082, 6449.097126402401, 6102.0, 6158.568900177123, 6177.598456100339, 6180.4746596538, 6185.907211391743, 6094.177286066324, 6388.840278993062, 6405.455536279282, 6407.615543067431, 6412.775552855627, 6205.751769929152, 6222.937770622236, 6223.128761973418, 6224.128621992834, 6227.719752611234, 6343.746250149942, 6358.936410635834, 6362.491000720024, 6368.299487056513, 6374.649394283173, 5943.138244954544, 6013.278406591237, 6219.067139929047, 6225.688715564294, 6239.282482514569], "unit": "score", "name": "prototype.html", "value": 4733.427834588589}, {"lowerIsBetter": false, "replicates": [667.3926726678724, 691.1567887177641, 726.5059759363634, 731.2943009995354, 767.0923335365038, 14080.577582672524, 14216.573502794907, 14239.71520569588, 14263.786043209348, 14289.142651440894, 12502.624921252354, 12739.299338536377, 13388.062835601511, 13546.593602191926, 13550.254735989542, 662.4369286106819, 815.759350991456, 819.8811172379986, 834.837206744685, 842.473454091193, 839.588601585225, 841.8316336732647, 841.8905542279496, 842.0695131879277, 842.0821304777791, 884.305819931354, 884.8628462588309, 885.716570697377, 886.0740526150156, 886.3219636977717, 703.1281211297979, 860.4020205956863, 874.3442418186361, 874.8031692869054, 880.4497189256715, 644.4908522267403, 644.735658380062, 645.122633218822, 645.33852800879, 645.644895307579, 13779.586612401645, 13827.585172444842, 13846.030777845555, 13856.515021974183, 13862.168269903737, 11906.1070419718, 12064.09519286057, 12487.188332758433, 12607.243565386107, 12638.431270592846, 9816.558254878548, 9878.110970012733, 9965.20278377728, 10149.39103653783, 10338.689839304832, 3387.0, 3417.96582034179, 3418.5555877735737, 3492.528508651325, 3508.6842184203288, 46239.76880115612, 46579.53420465786, 46920.29619555709, 47047.52952470466, 47304.086989126015, 8893.599788009555, 9088.136627020422, 9185.173334399802, 9232.769180770534, 9283.11810378013, 17936.641267174844, 18126.0, 18147.18337674808, 18153.45695615861, 18393.54016149607, 6371.52213583983, 6371.55399122057, 6537.477001839841, 7387.076615423072, 7587.127480339721, 4108.5275193353145, 4141.254574176617, 4209.915801683949, 4235.53409124996, 4319.805608747551, 3092.9072127835752, 3097.4424603571574, 3112.797668151563, 3132.545780861762, 3148.449021421242, 513.9460356662571, 525.836990532936, 526.5787370103978, 526.7234701781518, 527.2644660698304, 490.8380234522599, 580.7764010855766, 585.3268740947944, 622.483338828771, 625.8967270400424, 7925.167857375008, 7982.68069277234, 8185.263326300662, 8203.0, 8293.253607175384, 546.2557686492744, 610.0970563565947, 615.9476444502268, 627.3162253144095, 656.5830697507117, 3671.3391589514144, 3741.420079887622, 3841.750286231386, 3857.209272099269, 3862.4743226425967, 53121.2031819523, 53659.0, 53903.730481347346, 57878.7106064467, 59403.108953365736, 44960.550394495636, 45035.774821125684, 45205.32192017123, 45654.54345456569, 48007.0, 45057.098858022655, 45797.0, 45892.54107458883, 46374.0, 46766.76616616895, 8179.713710020121, 8187.345012399113, 8369.539675317916, 8438.873416898874, 8470.237678608955, 34509.0, 34763.478547821294, 35361.82319088388, 35707.0, 35733.64266357303, 41852.58147418609, 41861.0, 44532.55467445284, 45041.54958450505, 45532.77233613811, 10586.788264234518, 10610.787784244118, 10632.0, 11098.50056747432, 11190.83213751778, 11197.832032519356, 11453.48459319316, 11525.193236473366, 11775.175737698279, 11901.285922844658, 10637.0, 10699.251052426567, 10840.403777791982, 10864.945675271572, 11085.168612353944, 10574.682759517227, 10635.574577016832, 10866.836997444887, 10913.454327283764, 10943.781124377309, 10521.316114452537, 10859.565617375532, 10927.125829933428, 10943.83584246253, 11227.55089796399, 9440.150386465251, 9473.100055494717, 9545.623928651446, 9746.658866939622, 9790.902090979, 8843.248323892542, 8874.423162494417, 8878.778030549289, 9539.945523152493, 9543.42739435636], "unit": "score", "name": "yui.html", "value": 6123.255088656474}], "name": "dromaeo_css", "value": 6791.5617736578115}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 112.0, 104.0, 111.0, 112.0, 113.0, 99.0, 114.0, 112.0, 109.0], "unit": "score", "name": "ai-astar", "value": 109.8}, {"lowerIsBetter": true, "replicates": [158.0, 127.0, 150.0, 167.0, 129.0, 159.0, 160.0, 128.0, 176.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 148.0}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 163.0, 163.0, 161.0, 162.0, 162.0, 164.0, 165.0, 166.0], "unit": "score", "name": "audio-dft", "value": 162.7}, {"lowerIsBetter": true, "replicates": [76.0, 76.0, 104.0, 96.0, 74.0, 76.0, 73.0, 120.0, 91.0, 76.0], "unit": "score", "name": "audio-fft", "value": 86.2}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 149.0, 93.0, 94.0, 93.0, 136.0, 94.0, 94.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 107.7}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.7}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.1}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [57.0, 60.0, 57.0, 56.0, 57.0, 57.0, 57.0, 65.0, 56.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.7}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 69.0, 68.0, 70.0, 69.0, 68.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.8}, {"lowerIsBetter": true, "replicates": [79.0, 81.0, 81.0, 80.0, 81.0, 81.0, 80.0, 81.0, 80.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.5}, {"lowerIsBetter": true, "replicates": [113.0, 118.0, 115.0, 112.0, 111.0, 122.0, 115.0, 120.0, 113.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.2}, {"lowerIsBetter": true, "replicates": [139.0, 129.0, 144.0, 142.0, 143.0, 133.0, 139.0, 136.0, 139.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 138.3}, {"lowerIsBetter": true, "replicates": [72.0, 69.0, 67.0, 67.0, 69.0, 67.0, 67.0, 68.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.9}], "name": "kraken", "value": 1501.0}]} 06:04:02 INFO - Return code: 0 06:04:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 06:04:02 INFO - # TBPL SUCCESS # 06:04:02 INFO - Running post-action listener: _resource_record_post_action 06:04:02 INFO - Running post-run listener: _resource_record_post_run 06:04:03 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 16384; Write bytes: 550232064; Read time: 592; Write time: 667400 06:04:03 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 240865280; Read time: 228; Write time: 367380 06:04:03 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 12288; Write bytes: 291991552; Read time: 364; Write time: 295116 06:04:03 INFO - Running post-run listener: _upload_blobber_files 06:04:03 INFO - Blob upload gear active. 06:04:03 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 06:04:03 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 06:04:03 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'] 06:04:03 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 06:04:03 INFO - (blobuploader) - INFO - Open directory for files ... 06:04:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 06:04:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:04:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:04:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:04:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:04:04 INFO - (blobuploader) - INFO - Done attempting. 06:04:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:04:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:04:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:04:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:04:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:04:05 INFO - (blobuploader) - INFO - Done attempting. 06:04:05 INFO - (blobuploader) - INFO - Iteration through files over. 06:04:05 INFO - Return code: 0 06:04:05 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 06:04:05 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 06:04:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7dd8740bfcb55099fe85d5fda0c83d290b51af3b11c332d438dbb6b7d18610494b9849ce6a3fd49dbe9dbcac7755f409b62a45db7923448406e9c695eee214b0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b905e88c1b07f14e11a2728ed9f29b74117d94fab4231bafdec95d52f0dc621d7d3873b00fd067e5d8ab744b32bb5bf1ae7ea0c8e487e423adb16d97ca48c1d"} 06:04:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 06:04:05 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 06:04:05 INFO - Contents: 06:04:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7dd8740bfcb55099fe85d5fda0c83d290b51af3b11c332d438dbb6b7d18610494b9849ce6a3fd49dbe9dbcac7755f409b62a45db7923448406e9c695eee214b0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b905e88c1b07f14e11a2728ed9f29b74117d94fab4231bafdec95d52f0dc621d7d3873b00fd067e5d8ab744b32bb5bf1ae7ea0c8e487e423adb16d97ca48c1d"} 06:04:05 INFO - Running post-run listener: copy_logs_to_upload_dir 06:04:05 INFO - Copying logs to upload dir... 06:04:05 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 06:04:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.981454 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-03-08 06:04:04.303200) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-08 06:04:04.307091) ========= 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=fa44defc139c4ba8574fe040000001db-1457443761.898035-2022830480 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/7dd8740bfcb55099fe85d5fda0c83d290b51af3b11c332d438dbb6b7d18610494b9849ce6a3fd49dbe9dbcac7755f409b62a45db7923448406e9c695eee214b0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b905e88c1b07f14e11a2728ed9f29b74117d94fab4231bafdec95d52f0dc621d7d3873b00fd067e5d8ab744b32bb5bf1ae7ea0c8e487e423adb16d97ca48c1d"} build_url:https://queue.taskcluster.net/v1/task/bJRKDbyBRE2GQA4HmJVgQg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011396 build_url: 'https://queue.taskcluster.net/v1/task/bJRKDbyBRE2GQA4HmJVgQg/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/7dd8740bfcb55099fe85d5fda0c83d290b51af3b11c332d438dbb6b7d18610494b9849ce6a3fd49dbe9dbcac7755f409b62a45db7923448406e9c695eee214b0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b905e88c1b07f14e11a2728ed9f29b74117d94fab4231bafdec95d52f0dc621d7d3873b00fd067e5d8ab744b32bb5bf1ae7ea0c8e487e423adb16d97ca48c1d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-08 06:04:04.336008) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 06:04:04.336801) ========= 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=fa44defc139c4ba8574fe040000001db-1457443761.898035-2022830480 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004589 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 06:04:04.420017) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-08 06:04:04.420760) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-08 06:04:04.421371) ========= ========= Total master_lag: 0.29 =========