builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-018 starttime: 1455240071.58 results: success (0) buildid: 20160211143012 builduid: 792af94e9f57474ba113882c38eed878 revision: f7233ec3a268a519e07cc65f042af59d18375816 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-11 17:21:11.580673) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-11 17:21:11.581145) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-11 17:21:11.581438) ========= 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=62c568580acbfdaac3eec7be000001dc-1455240070.764407-1476042235 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006369 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-11 17:21:11.604474) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-11 17:21:11.604770) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-11 17:21:11.630262) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 17:21:11.630571) ========= 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=62c568580acbfdaac3eec7be000001dc-1455240070.764407-1476042235 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023861 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 17:21:11.676619) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-11 17:21:11.676927) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-11 17:21:11.677294) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 17:21:11.677566) ========= 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=62c568580acbfdaac3eec7be000001dc-1455240070.764407-1476042235 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-11 17:21:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 58.8M=0s 2016-02-11 17:21:11 (58.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.165323 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 17:21:11.855385) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 17:21:11.855721) ========= 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=62c568580acbfdaac3eec7be000001dc-1455240070.764407-1476042235 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.078672 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 17:21:11.946086) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 17:21:11.946466) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev f7233ec3a268a519e07cc65f042af59d18375816 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev f7233ec3a268a519e07cc65f042af59d18375816 --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=62c568580acbfdaac3eec7be000001dc-1455240070.764407-1476042235 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-11 17:21:11,985 truncating revision to first 12 chars 2016-02-11 17:21:11,985 Setting DEBUG logging. 2016-02-11 17:21:11,985 attempt 1/10 2016-02-11 17:21:11,985 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/f7233ec3a268?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-11 17:21:12,236 unpacking tar archive at: b2g-inbound-f7233ec3a268/testing/mozharness/ program finished with exit code 0 elapsedTime=0.559053 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 17:21:12.518425) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-11 17:21:12.518775) ========= echo f7233ec3a268a519e07cc65f042af59d18375816 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'f7233ec3a268a519e07cc65f042af59d18375816'] 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=62c568580acbfdaac3eec7be000001dc-1455240070.764407-1476042235 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False f7233ec3a268a519e07cc65f042af59d18375816 program finished with exit code 0 elapsedTime=0.003382 script_repo_revision: 'f7233ec3a268a519e07cc65f042af59d18375816' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-11 17:21:12.566436) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-11 17:21:12.566735) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-11 17:21:12.576319) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-02-11 17:21:12.576585) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1455240070.764407-1476042235 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:21:12 INFO - MultiFileLogger online at 20160211 17:21:12 in /builds/slave/test-pgo 17:21:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 17:21:12 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 17:21:12 INFO - {'append_to_log': False, 17:21:12 INFO - 'base_work_dir': '/builds/slave/test-pgo', 17:21:12 INFO - 'blob_upload_branch': 'B2G-Inbound', 17:21:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 17:21:12 INFO - 'branch': 'B2G-Inbound', 17:21:12 INFO - 'buildbot_json_path': 'buildprops.json', 17:21:12 INFO - 'config_files': ('talos/linux_config.py',), 17:21:12 INFO - 'default_actions': ('clobber', 17:21:12 INFO - 'read-buildbot-config', 17:21:12 INFO - 'download-and-extract', 17:21:12 INFO - 'populate-webroot', 17:21:12 INFO - 'create-virtualenv', 17:21:12 INFO - 'install', 17:21:12 INFO - 'run-tests'), 17:21:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:21:12 INFO - 'download_minidump_stackwalk': True, 17:21:12 INFO - 'download_symbols': 'ondemand', 17:21:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:21:12 INFO - 'tooltool.py': '/tools/tooltool.py', 17:21:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:21:12 INFO - '/tools/misc-python/virtualenv.py')}, 17:21:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:21:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:21:12 INFO - 'installer_path': 'installer.exe', 17:21:12 INFO - 'log_level': 'info', 17:21:12 INFO - 'log_name': 'talos', 17:21:12 INFO - 'log_to_console': True, 17:21:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:21:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:21:12 INFO - 'opt_config_files': (), 17:21:12 INFO - 'pip_index': False, 17:21:12 INFO - 'sps_profile': False, 17:21:12 INFO - 'sps_profile_interval': 0, 17:21:12 INFO - 'suite': 'dromaeojs', 17:21:12 INFO - 'system_bits': '32', 17:21:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:21:12 INFO - 'title': 'talos-linux64-ix-018', 17:21:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:21:12 INFO - 'use_talos_json': True, 17:21:12 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 17:21:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:21:12 INFO - 'work_dir': 'build'} 17:21:12 INFO - ##### 17:21:12 INFO - ##### Running clobber step. 17:21:12 INFO - ##### 17:21:12 INFO - Running pre-action listener: _resource_record_pre_action 17:21:12 INFO - Running main action method: clobber 17:21:12 INFO - rmtree: /builds/slave/test-pgo/build 17:21:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 17:21:17 INFO - Running post-action listener: _resource_record_post_action 17:21:17 INFO - ##### 17:21:17 INFO - ##### Running read-buildbot-config step. 17:21:17 INFO - ##### 17:21:17 INFO - Running pre-action listener: _resource_record_pre_action 17:21:17 INFO - Running main action method: read_buildbot_config 17:21:17 INFO - Using buildbot properties: 17:21:17 INFO - { 17:21:17 INFO - "project": "", 17:21:17 INFO - "product": "firefox", 17:21:17 INFO - "script_repo_revision": "production", 17:21:17 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 17:21:17 INFO - "repository": "", 17:21:17 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 17:21:17 INFO - "buildid": "20160211143012", 17:21:17 INFO - "pgo_build": "True", 17:21:17 INFO - "basedir": "/builds/slave/test-pgo", 17:21:17 INFO - "buildnumber": 260, 17:21:17 INFO - "slavename": "talos-linux64-ix-018", 17:21:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:21:17 INFO - "platform": "ubuntu64_hw", 17:21:17 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 17:21:17 INFO - "branch": "b2g-inbound", 17:21:17 INFO - "repo_path": "integration/b2g-inbound", 17:21:17 INFO - "revision": "f7233ec3a268a519e07cc65f042af59d18375816", 17:21:17 INFO - "stage_platform": "linux64-pgo", 17:21:17 INFO - "builduid": "792af94e9f57474ba113882c38eed878", 17:21:17 INFO - "slavebuilddir": "test" 17:21:17 INFO - } 17:21:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/dtI9QKRQQ2mp1iScemiuEw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 17:21:17 INFO - Running post-action listener: _resource_record_post_action 17:21:17 INFO - ##### 17:21:17 INFO - ##### Running download-and-extract step. 17:21:17 INFO - ##### 17:21:17 INFO - Running pre-action listener: _resource_record_pre_action 17:21:17 INFO - Running main action method: download_and_extract 17:21:17 INFO - mkdir: /builds/slave/test-pgo/build/tests 17:21:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:21:17 INFO - https://queue.taskcluster.net/v1/task/dtI9QKRQQ2mp1iScemiuEw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 17:21:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtI9QKRQQ2mp1iScemiuEw/artifacts/public/build/test_packages.json 17:21:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtI9QKRQQ2mp1iScemiuEw/artifacts/public/build/test_packages.json 17:21:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtI9QKRQQ2mp1iScemiuEw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 17:21:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtI9QKRQQ2mp1iScemiuEw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 17:21:18 INFO - Downloaded 1448 bytes. 17:21:18 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 17:21:18 INFO - Using the following test package requirements: 17:21:18 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 17:21:18 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:21:18 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:21:18 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:21:18 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:21:18 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:21:18 INFO - u'jsshell-linux-x86_64.zip'], 17:21:18 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:21:18 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:21:18 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 17:21:18 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:21:18 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:21:18 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:21:18 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:21:18 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:21:18 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:21:18 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 17:21:18 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:21:18 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:21:18 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:21:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:21:18 INFO - https://queue.taskcluster.net/v1/task/dtI9QKRQQ2mp1iScemiuEw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:21:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtI9QKRQQ2mp1iScemiuEw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 17:21:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtI9QKRQQ2mp1iScemiuEw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 17:21:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtI9QKRQQ2mp1iScemiuEw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 17:21:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtI9QKRQQ2mp1iScemiuEw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:21:19 INFO - Downloaded 23575482 bytes. 17:21:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 17:21:19 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 17:21:20 INFO - Return code: 0 17:21:20 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:21:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:21:20 INFO - https://queue.taskcluster.net/v1/task/dtI9QKRQQ2mp1iScemiuEw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:21:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtI9QKRQQ2mp1iScemiuEw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 17:21:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtI9QKRQQ2mp1iScemiuEw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 17:21:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtI9QKRQQ2mp1iScemiuEw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 17:21:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtI9QKRQQ2mp1iScemiuEw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:21:21 INFO - Downloaded 23575482 bytes. 17:21:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 17:21:21 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 17:21:22 INFO - Return code: 0 17:21:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:21:22 INFO - https://queue.taskcluster.net/v1/task/dtI9QKRQQ2mp1iScemiuEw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:21:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtI9QKRQQ2mp1iScemiuEw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 17:21:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtI9QKRQQ2mp1iScemiuEw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 17:21:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtI9QKRQQ2mp1iScemiuEw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 17:21:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtI9QKRQQ2mp1iScemiuEw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:21:23 INFO - Downloaded 10706547 bytes. 17:21:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 17:21:23 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 17:21:24 INFO - Return code: 0 17:21:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:21:24 INFO - https://queue.taskcluster.net/v1/task/dtI9QKRQQ2mp1iScemiuEw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:21:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtI9QKRQQ2mp1iScemiuEw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 17:21:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtI9QKRQQ2mp1iScemiuEw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 17:21:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtI9QKRQQ2mp1iScemiuEw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 17:21:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtI9QKRQQ2mp1iScemiuEw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:21:25 INFO - Downloaded 56580827 bytes. 17:21:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dtI9QKRQQ2mp1iScemiuEw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 17:21:25 INFO - mkdir: /builds/slave/test-pgo/properties 17:21:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 17:21:25 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 17:21:25 INFO - Contents: 17:21:25 INFO - build_url:https://queue.taskcluster.net/v1/task/dtI9QKRQQ2mp1iScemiuEw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 17:21:26 INFO - Running post-action listener: _resource_record_post_action 17:21:26 INFO - Running post-action listener: set_extra_try_arguments 17:21:26 INFO - ##### 17:21:26 INFO - ##### Running populate-webroot step. 17:21:26 INFO - ##### 17:21:26 INFO - Running pre-action listener: _resource_record_pre_action 17:21:26 INFO - Running main action method: populate_webroot 17:21:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:21:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:21:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:21:26 INFO - '--tppagecycles', 17:21:26 INFO - '7'], 17:21:26 INFO - 'tests': ['tsvgm']}}, 17:21:26 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:21:26 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:21:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:21:26 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 17:21:26 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:21:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:21:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:21:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:21:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:21:26 INFO - 'talos_options': ['--e10s'], 17:21:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:21:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:21:26 INFO - 'tests': ['damp', 'tps']}, 17:21:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:21:26 INFO - 'talos_options': ['--e10s'], 17:21:26 INFO - 'tests': ['damp', 'tps']}, 17:21:26 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:21:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:21:26 INFO - 'other': {'tests': ['a11yr', 17:21:26 INFO - 'ts_paint', 17:21:26 INFO - 'tpaint', 17:21:26 INFO - 'sessionrestore', 17:21:26 INFO - 'sessionrestore_no_auto_restore']}, 17:21:26 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:21:26 INFO - 'tests': ['a11yr', 17:21:26 INFO - 'ts_paint', 17:21:26 INFO - 'tpaint', 17:21:26 INFO - 'sessionrestore', 17:21:26 INFO - 'sessionrestore_no_auto_restore']}, 17:21:26 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:21:26 INFO - 'tests': ['a11yr', 17:21:26 INFO - 'ts_paint', 17:21:26 INFO - 'tpaint', 17:21:26 INFO - 'sessionrestore', 17:21:26 INFO - 'sessionrestore_no_auto_restore']}, 17:21:26 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:21:26 INFO - 'tests': ['a11yr', 17:21:26 INFO - 'ts_paint', 17:21:26 INFO - 'tpaint', 17:21:26 INFO - 'sessionrestore', 17:21:26 INFO - 'sessionrestore_no_auto_restore']}, 17:21:26 INFO - 'other_l64': {'tests': ['a11yr', 17:21:26 INFO - 'ts_paint', 17:21:26 INFO - 'tpaint', 17:21:26 INFO - 'sessionrestore', 17:21:26 INFO - 'sessionrestore_no_auto_restore']}, 17:21:26 INFO - 'other_nol64': {'tests': ['a11yr', 17:21:26 INFO - 'ts_paint', 17:21:26 INFO - 'tpaint', 17:21:26 INFO - 'sessionrestore', 17:21:26 INFO - 'sessionrestore_no_auto_restore']}, 17:21:26 INFO - 'svgr': {'tests': ['tsvgx', 17:21:26 INFO - 'tsvgr_opacity', 17:21:26 INFO - 'tart', 17:21:26 INFO - 'tscrollx', 17:21:26 INFO - 'cart']}, 17:21:26 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:21:26 INFO - 'tests': ['tsvgx', 17:21:26 INFO - 'tsvgr_opacity', 17:21:26 INFO - 'tart', 17:21:26 INFO - 'tscrollx', 17:21:26 INFO - 'cart']}, 17:21:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:21:26 INFO - 'tests': ['tp5o']}, 17:21:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:21:26 INFO - 'talos_options': ['--e10s'], 17:21:26 INFO - 'tests': ['tp5o']}, 17:21:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:21:26 INFO - 'talos_options': ['--xperf_path', 17:21:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:21:26 INFO - 'tests': ['tp5n']}, 17:21:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:21:26 INFO - 'talos_options': ['--e10s', 17:21:26 INFO - '--xperf_path', 17:21:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:21:26 INFO - 'tests': ['tp5n']}}, 17:21:26 INFO - 'talos.zip': {'path': '', 17:21:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:21:26 INFO - Running post-action listener: _resource_record_post_action 17:21:26 INFO - ##### 17:21:26 INFO - ##### Running create-virtualenv step. 17:21:26 INFO - ##### 17:21:26 INFO - Running pre-action listener: _resource_record_pre_action 17:21:26 INFO - Running main action method: create_virtualenv 17:21:26 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 17:21:26 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 17:21:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 17:21:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:21:26 INFO - Using real prefix '/usr' 17:21:26 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 17:21:27 INFO - Installing distribute.............................................................................................................................................................................................done. 17:21:29 INFO - Installing pip.................done. 17:21:29 INFO - Return code: 0 17:21:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 17:21:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:21:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:21:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:29 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcabaf00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1395670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14248c0>, '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 0x14257c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1425c50>, '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': '62c568580acbfdaac3eec7be000001dc-1455240070.764407-1476042235', '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 17:21:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 17:21:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:21:29 INFO - Using env: {'DISPLAY': ':0', 17:21:29 INFO - 'HOME': '/home/cltbld', 17:21:29 INFO - 'LANG': 'en_US.UTF-8', 17:21:29 INFO - 'LANGUAGE': 'en_US:en', 17:21:29 INFO - 'LOGNAME': 'cltbld', 17:21:29 INFO - 'MAIL': '/var/mail/cltbld', 17:21:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:29 INFO - 'MOZ_NO_REMOTE': '1', 17:21:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:21:29 INFO - 'NO_EM_RESTART': '1', 17:21:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:21:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:21:29 INFO - 'PWD': '/builds/slave/test-pgo', 17:21:29 INFO - 'SHELL': '/bin/bash', 17:21:29 INFO - 'SHLVL': '1', 17:21:29 INFO - 'TERM': 'linux', 17:21:29 INFO - 'TMOUT': '86400', 17:21:29 INFO - 'USER': 'cltbld', 17:21:29 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1455240070.764407-1476042235', 17:21:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:29 INFO - '_': '/tools/buildbot/bin/python'} 17:21:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21:29 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:21:29 INFO - Cleaning up... 17:21:29 INFO - Return code: 0 17:21:29 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 17:21:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:21:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:21:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:29 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcabaf00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1395670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14248c0>, '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 0x14257c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1425c50>, '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': '62c568580acbfdaac3eec7be000001dc-1455240070.764407-1476042235', '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 17:21:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 17:21:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 17:21:29 INFO - Using env: {'DISPLAY': ':0', 17:21:29 INFO - 'HOME': '/home/cltbld', 17:21:29 INFO - 'LANG': 'en_US.UTF-8', 17:21:29 INFO - 'LANGUAGE': 'en_US:en', 17:21:29 INFO - 'LOGNAME': 'cltbld', 17:21:29 INFO - 'MAIL': '/var/mail/cltbld', 17:21:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:29 INFO - 'MOZ_NO_REMOTE': '1', 17:21:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:21:29 INFO - 'NO_EM_RESTART': '1', 17:21:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:21:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:21:29 INFO - 'PWD': '/builds/slave/test-pgo', 17:21:29 INFO - 'SHELL': '/bin/bash', 17:21:29 INFO - 'SHLVL': '1', 17:21:29 INFO - 'TERM': 'linux', 17:21:29 INFO - 'TMOUT': '86400', 17:21:29 INFO - 'USER': 'cltbld', 17:21:29 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1455240070.764407-1476042235', 17:21:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:29 INFO - '_': '/tools/buildbot/bin/python'} 17:21:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21:30 INFO - Downloading/unpacking psutil>=0.7.1 17:21:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 17:21:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:21:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:21:31 INFO - Installing collected packages: psutil 17:21:31 INFO - Running setup.py install for psutil 17:21:31 INFO - building 'psutil._psutil_linux' extension 17:21:31 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 17:21:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 17:21:32 INFO - building 'psutil._psutil_posix' extension 17:21:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 17:21:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 17:21:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:21:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:21:32 INFO - Successfully installed psutil 17:21:32 INFO - Cleaning up... 17:21:32 INFO - Return code: 0 17:21:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 17:21:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:21:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:32 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcabaf00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1395670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14248c0>, '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 0x14257c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1425c50>, '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': '62c568580acbfdaac3eec7be000001dc-1455240070.764407-1476042235', '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 17:21:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 17:21:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 17:21:32 INFO - Using env: {'DISPLAY': ':0', 17:21:32 INFO - 'HOME': '/home/cltbld', 17:21:32 INFO - 'LANG': 'en_US.UTF-8', 17:21:32 INFO - 'LANGUAGE': 'en_US:en', 17:21:32 INFO - 'LOGNAME': 'cltbld', 17:21:32 INFO - 'MAIL': '/var/mail/cltbld', 17:21:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:32 INFO - 'MOZ_NO_REMOTE': '1', 17:21:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:21:32 INFO - 'NO_EM_RESTART': '1', 17:21:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:21:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:21:32 INFO - 'PWD': '/builds/slave/test-pgo', 17:21:32 INFO - 'SHELL': '/bin/bash', 17:21:32 INFO - 'SHLVL': '1', 17:21:32 INFO - 'TERM': 'linux', 17:21:32 INFO - 'TMOUT': '86400', 17:21:32 INFO - 'USER': 'cltbld', 17:21:32 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1455240070.764407-1476042235', 17:21:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:32 INFO - '_': '/tools/buildbot/bin/python'} 17:21:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21:32 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:34 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:21:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:21:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:21:34 INFO - Installing collected packages: mozsystemmonitor 17:21:34 INFO - Running setup.py install for mozsystemmonitor 17:21:34 INFO - Successfully installed mozsystemmonitor 17:21:34 INFO - Cleaning up... 17:21:35 INFO - Return code: 0 17:21:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 17:21:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:21:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:21:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:35 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcabaf00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1395670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14248c0>, '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 0x14257c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1425c50>, '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': '62c568580acbfdaac3eec7be000001dc-1455240070.764407-1476042235', '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 17:21:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 17:21:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:21:35 INFO - Using env: {'DISPLAY': ':0', 17:21:35 INFO - 'HOME': '/home/cltbld', 17:21:35 INFO - 'LANG': 'en_US.UTF-8', 17:21:35 INFO - 'LANGUAGE': 'en_US:en', 17:21:35 INFO - 'LOGNAME': 'cltbld', 17:21:35 INFO - 'MAIL': '/var/mail/cltbld', 17:21:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:35 INFO - 'MOZ_NO_REMOTE': '1', 17:21:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:21:35 INFO - 'NO_EM_RESTART': '1', 17:21:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:21:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:21:35 INFO - 'PWD': '/builds/slave/test-pgo', 17:21:35 INFO - 'SHELL': '/bin/bash', 17:21:35 INFO - 'SHLVL': '1', 17:21:35 INFO - 'TERM': 'linux', 17:21:35 INFO - 'TMOUT': '86400', 17:21:35 INFO - 'USER': 'cltbld', 17:21:35 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1455240070.764407-1476042235', 17:21:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:35 INFO - '_': '/tools/buildbot/bin/python'} 17:21:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21:36 INFO - Downloading/unpacking blobuploader==1.2.4 17:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:38 INFO - Downloading blobuploader-1.2.4.tar.gz 17:21:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:21:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:21:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 17:21:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:21:39 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 17:21:39 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 17:21:39 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 17:21:39 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 17:21:39 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 17:21:39 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 17:21:39 INFO - Downloading docopt-0.6.1.tar.gz 17:21:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 17:21:39 INFO - Installing collected packages: blobuploader, requests, docopt 17:21:39 INFO - Running setup.py install for blobuploader 17:21:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:21:39 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 17:21:39 INFO - Running setup.py install for requests 17:21:40 INFO - Running setup.py install for docopt 17:21:40 INFO - Successfully installed blobuploader requests docopt 17:21:40 INFO - Cleaning up... 17:21:40 INFO - Return code: 0 17:21:40 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:21:40 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')]} 17:21:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:40 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')]} 17:21:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:40 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 0x7fcabaf00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1395670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14248c0>, '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 0x14257c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1425c50>, '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': '62c568580acbfdaac3eec7be000001dc-1455240070.764407-1476042235', '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 17:21:40 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 17:21:40 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 17:21:40 INFO - Using env: {'DISPLAY': ':0', 17:21:40 INFO - 'HOME': '/home/cltbld', 17:21:40 INFO - 'LANG': 'en_US.UTF-8', 17:21:40 INFO - 'LANGUAGE': 'en_US:en', 17:21:40 INFO - 'LOGNAME': 'cltbld', 17:21:40 INFO - 'MAIL': '/var/mail/cltbld', 17:21:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:40 INFO - 'MOZ_NO_REMOTE': '1', 17:21:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:21:40 INFO - 'NO_EM_RESTART': '1', 17:21:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:21:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:21:40 INFO - 'PWD': '/builds/slave/test-pgo', 17:21:40 INFO - 'SHELL': '/bin/bash', 17:21:40 INFO - 'SHLVL': '1', 17:21:40 INFO - 'TERM': 'linux', 17:21:40 INFO - 'TMOUT': '86400', 17:21:40 INFO - 'USER': 'cltbld', 17:21:40 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1455240070.764407-1476042235', 17:21:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:40 INFO - '_': '/tools/buildbot/bin/python'} 17:21:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:21:40 INFO - Running setup.py (path:/tmp/pip-yXfITi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:21:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:21:40 INFO - Running setup.py (path:/tmp/pip-bfka5b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:21:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:21:40 INFO - Running setup.py (path:/tmp/pip-iWMENR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:21:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:21:40 INFO - Running setup.py (path:/tmp/pip-DhpQfo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:21:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:21:40 INFO - Running setup.py (path:/tmp/pip-cNcce3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:21:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:21:40 INFO - Running setup.py (path:/tmp/pip-NrbLMH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:21:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:21:40 INFO - Running setup.py (path:/tmp/pip-n1_K1k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:21:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:21:40 INFO - Running setup.py (path:/tmp/pip-w69XHe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:21:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:21:41 INFO - Running setup.py (path:/tmp/pip-nlsCYx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:21:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:21:41 INFO - Running setup.py (path:/tmp/pip-vYiHgu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:21:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:21:41 INFO - Running setup.py (path:/tmp/pip-AszZ7h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:21:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:21:41 INFO - Running setup.py (path:/tmp/pip-D8jylO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:21:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:21:41 INFO - Running setup.py (path:/tmp/pip-_Dc5uM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:21:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:21:41 INFO - Running setup.py (path:/tmp/pip-BtFtP9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:21:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:21:41 INFO - Running setup.py (path:/tmp/pip-38CqUM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:21:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:21:41 INFO - Running setup.py (path:/tmp/pip-Fis9P8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:21:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:21:41 INFO - Running setup.py (path:/tmp/pip-8RSTJP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:21:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:21:41 INFO - Running setup.py install for manifestparser 17:21:41 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 17:21:41 INFO - Running setup.py install for mozcrash 17:21:41 INFO - Running setup.py install for mozdebug 17:21:41 INFO - Running setup.py install for mozdevice 17:21:42 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 17:21:42 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 17:21:42 INFO - Running setup.py install for mozfile 17:21:42 INFO - Running setup.py install for mozhttpd 17:21:42 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 17:21:42 INFO - Running setup.py install for mozinfo 17:21:42 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 17:21:42 INFO - Running setup.py install for mozInstall 17:21:42 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 17:21:42 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 17:21:42 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 17:21:42 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 17:21:42 INFO - Running setup.py install for mozleak 17:21:42 INFO - Running setup.py install for mozlog 17:21:42 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 17:21:42 INFO - Running setup.py install for moznetwork 17:21:42 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 17:21:42 INFO - Running setup.py install for mozprocess 17:21:42 INFO - Running setup.py install for mozprofile 17:21:43 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 17:21:43 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 17:21:43 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 17:21:43 INFO - Running setup.py install for mozrunner 17:21:43 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 17:21:43 INFO - Running setup.py install for mozscreenshot 17:21:43 INFO - Running setup.py install for moztest 17:21:43 INFO - Running setup.py install for mozversion 17:21:43 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 17:21:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:21:43 INFO - Cleaning up... 17:21:43 INFO - Return code: 0 17:21:43 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:21: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')]} 17:21:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21: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')]} 17:21:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:43 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 0x7fcabaf00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1395670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14248c0>, '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 0x14257c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1425c50>, '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': '62c568580acbfdaac3eec7be000001dc-1455240070.764407-1476042235', '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 17:21:43 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 17:21:43 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 17:21:43 INFO - Using env: {'DISPLAY': ':0', 17:21:43 INFO - 'HOME': '/home/cltbld', 17:21:43 INFO - 'LANG': 'en_US.UTF-8', 17:21:43 INFO - 'LANGUAGE': 'en_US:en', 17:21:43 INFO - 'LOGNAME': 'cltbld', 17:21:43 INFO - 'MAIL': '/var/mail/cltbld', 17:21:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:43 INFO - 'MOZ_NO_REMOTE': '1', 17:21:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:21:43 INFO - 'NO_EM_RESTART': '1', 17:21:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:21:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:21:43 INFO - 'PWD': '/builds/slave/test-pgo', 17:21:43 INFO - 'SHELL': '/bin/bash', 17:21:43 INFO - 'SHLVL': '1', 17:21:43 INFO - 'TERM': 'linux', 17:21:43 INFO - 'TMOUT': '86400', 17:21:43 INFO - 'USER': 'cltbld', 17:21:43 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1455240070.764407-1476042235', 17:21:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:43 INFO - '_': '/tools/buildbot/bin/python'} 17:21:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:21:43 INFO - Running setup.py (path:/tmp/pip-D80kMt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:21:43 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)) 17:21:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:21:43 INFO - Running setup.py (path:/tmp/pip-g90iY0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:21:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 17:21:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:21:43 INFO - Running setup.py (path:/tmp/pip-lGWyYk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:21:43 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)) 17:21:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:21:43 INFO - Running setup.py (path:/tmp/pip-EPxkUc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:21:43 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)) 17:21:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:21:43 INFO - Running setup.py (path:/tmp/pip-YuKaUK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:21:44 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)) 17:21:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:21:44 INFO - Running setup.py (path:/tmp/pip-0cdcAM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:21:44 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)) 17:21:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:21:44 INFO - Running setup.py (path:/tmp/pip-6N_j9w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:21:44 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)) 17:21:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:21:44 INFO - Running setup.py (path:/tmp/pip-j0LE2n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:21:44 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)) 17:21:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:21:44 INFO - Running setup.py (path:/tmp/pip-wH7Yim-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:21:44 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)) 17:21:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:21:44 INFO - Running setup.py (path:/tmp/pip-u1lb7_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:21:44 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)) 17:21:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:21:44 INFO - Running setup.py (path:/tmp/pip-7AlTjg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:21:44 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)) 17:21:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:21:44 INFO - Running setup.py (path:/tmp/pip-2fGgFB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:21:44 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)) 17:21:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:21:44 INFO - Running setup.py (path:/tmp/pip-VWJYYS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:21:44 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)) 17:21:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:21:44 INFO - Running setup.py (path:/tmp/pip-VT4HRO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:21:44 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)) 17:21:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:21:44 INFO - Running setup.py (path:/tmp/pip-HpYcl3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:21:44 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)) 17:21:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:21:44 INFO - Running setup.py (path:/tmp/pip-BjE15B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:21:44 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)) 17:21:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:21:44 INFO - Running setup.py (path:/tmp/pip-e4wZtZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:21:44 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)) 17:21:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 17:21:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 17:21:44 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)) 17:21:44 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)) 17:21:44 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)) 17:21:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 17:21:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:46 INFO - Downloading blessings-1.6.tar.gz 17:21:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 17:21:46 INFO - Installing collected packages: blessings 17:21:46 INFO - Running setup.py install for blessings 17:21:46 INFO - Successfully installed blessings 17:21:46 INFO - Cleaning up... 17:21:46 INFO - Return code: 0 17:21:46 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 17:21:46 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:21:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:21:47 INFO - Reading from file tmpfile_stdout 17:21:47 INFO - Current package versions: 17:21:47 INFO - argparse == 1.2.1 17:21:47 INFO - blessings == 1.6 17:21:47 INFO - blobuploader == 1.2.4 17:21:47 INFO - docopt == 0.6.1 17:21:47 INFO - manifestparser == 1.1 17:21:47 INFO - mozInstall == 1.12 17:21:47 INFO - mozcrash == 0.16 17:21:47 INFO - mozdebug == 0.1 17:21:47 INFO - mozdevice == 0.48 17:21:47 INFO - mozfile == 1.2 17:21:47 INFO - mozhttpd == 0.7 17:21:47 INFO - mozinfo == 0.9 17:21:47 INFO - mozleak == 0.1 17:21:47 INFO - mozlog == 3.1 17:21:47 INFO - moznetwork == 0.27 17:21:47 INFO - mozprocess == 0.22 17:21:47 INFO - mozprofile == 0.28 17:21:47 INFO - mozrunner == 6.11 17:21:47 INFO - mozscreenshot == 0.1 17:21:47 INFO - mozsystemmonitor == 0.0 17:21:47 INFO - moztest == 0.7 17:21:47 INFO - mozversion == 1.4 17:21:47 INFO - psutil == 3.1.1 17:21:47 INFO - requests == 1.2.3 17:21:47 INFO - wsgiref == 0.1.2 17:21:47 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:21:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:21:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:47 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7fcabaf00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1395670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14248c0>, '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 0x14257c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1425c50>, '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': '62c568580acbfdaac3eec7be000001dc-1455240070.764407-1476042235', '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 17:21:47 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 17:21:47 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 17:21:47 INFO - Using env: {'DISPLAY': ':0', 17:21:47 INFO - 'HOME': '/home/cltbld', 17:21:47 INFO - 'LANG': 'en_US.UTF-8', 17:21:47 INFO - 'LANGUAGE': 'en_US:en', 17:21:47 INFO - 'LOGNAME': 'cltbld', 17:21:47 INFO - 'MAIL': '/var/mail/cltbld', 17:21:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:47 INFO - 'MOZ_NO_REMOTE': '1', 17:21:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:21:47 INFO - 'NO_EM_RESTART': '1', 17:21:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:21:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:21:47 INFO - 'PWD': '/builds/slave/test-pgo', 17:21:47 INFO - 'SHELL': '/bin/bash', 17:21:47 INFO - 'SHLVL': '1', 17:21:47 INFO - 'TERM': 'linux', 17:21:47 INFO - 'TMOUT': '86400', 17:21:47 INFO - 'USER': 'cltbld', 17:21:47 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1455240070.764407-1476042235', 17:21:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:47 INFO - '_': '/tools/buildbot/bin/python'} 17:21:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21:47 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)) 17:21:47 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)) 17:21:47 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)) 17:21:47 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)) 17:21:47 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)) 17:21:47 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)) 17:21:47 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)) 17:21:47 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)) 17:21:47 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)) 17:21:47 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)) 17:21:47 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)) 17:21:47 INFO - Cleaning up... 17:21:47 INFO - Return code: 0 17:21:47 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 17:21:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:21:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:47 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcabaf00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1395670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14248c0>, '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 0x14257c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1425c50>, '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': '62c568580acbfdaac3eec7be000001dc-1455240070.764407-1476042235', '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 17:21:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 17:21:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:21:47 INFO - Using env: {'DISPLAY': ':0', 17:21:47 INFO - 'HOME': '/home/cltbld', 17:21:47 INFO - 'LANG': 'en_US.UTF-8', 17:21:47 INFO - 'LANGUAGE': 'en_US:en', 17:21:47 INFO - 'LOGNAME': 'cltbld', 17:21:47 INFO - 'MAIL': '/var/mail/cltbld', 17:21:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:47 INFO - 'MOZ_NO_REMOTE': '1', 17:21:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:21:47 INFO - 'NO_EM_RESTART': '1', 17:21:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:21:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:21:47 INFO - 'PWD': '/builds/slave/test-pgo', 17:21:47 INFO - 'SHELL': '/bin/bash', 17:21:47 INFO - 'SHLVL': '1', 17:21:47 INFO - 'TERM': 'linux', 17:21:47 INFO - 'TMOUT': '86400', 17:21:47 INFO - 'USER': 'cltbld', 17:21:47 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1455240070.764407-1476042235', 17:21:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:47 INFO - '_': '/tools/buildbot/bin/python'} 17:21:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21:47 INFO - Downloading/unpacking jsonschema 17:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:21:49 INFO - Downloading/unpacking functools32 (from jsonschema) 17:21:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:49 INFO - Downloading functools32-3.2.3-2.tar.gz 17:21:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 17:21:49 INFO - warning: no files found matching '*.txt' 17:21:49 INFO - no previously-included directories found matching 'build' 17:21:49 INFO - no previously-included directories found matching 'dist' 17:21:49 INFO - no previously-included directories found matching '.git*' 17:21:49 INFO - Installing collected packages: jsonschema, functools32 17:21:49 INFO - Running setup.py install for functools32 17:21:49 INFO - warning: no files found matching '*.txt' 17:21:49 INFO - no previously-included directories found matching 'build' 17:21:49 INFO - no previously-included directories found matching 'dist' 17:21:49 INFO - no previously-included directories found matching '.git*' 17:21:49 INFO - Successfully installed jsonschema functools32 17:21:49 INFO - Cleaning up... 17:21:49 INFO - Return code: 0 17:21:49 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 17:21: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')]} 17:21:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21: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')]} 17:21:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcabaf00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1395670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14248c0>, '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 0x14257c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1425c50>, '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': '62c568580acbfdaac3eec7be000001dc-1455240070.764407-1476042235', '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 17:21: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', 'flake8'] in /builds/slave/test-pgo/build 17:21: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 flake8 17:21:49 INFO - Using env: {'DISPLAY': ':0', 17:21:49 INFO - 'HOME': '/home/cltbld', 17:21:49 INFO - 'LANG': 'en_US.UTF-8', 17:21:49 INFO - 'LANGUAGE': 'en_US:en', 17:21:49 INFO - 'LOGNAME': 'cltbld', 17:21:49 INFO - 'MAIL': '/var/mail/cltbld', 17:21:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:49 INFO - 'MOZ_NO_REMOTE': '1', 17:21:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:21:49 INFO - 'NO_EM_RESTART': '1', 17:21:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:21:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:21:49 INFO - 'PWD': '/builds/slave/test-pgo', 17:21:49 INFO - 'SHELL': '/bin/bash', 17:21:49 INFO - 'SHLVL': '1', 17:21:49 INFO - 'TERM': 'linux', 17:21:49 INFO - 'TMOUT': '86400', 17:21:49 INFO - 'USER': 'cltbld', 17:21:49 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1455240070.764407-1476042235', 17:21:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:49 INFO - '_': '/tools/buildbot/bin/python'} 17:21:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21:50 INFO - Downloading/unpacking flake8 17:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:51 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:21:51 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:52 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:21:52 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:52 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 17:21:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:21:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:21:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:21:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:21:52 INFO - no previously-included directories found matching 'docs/_build' 17:21:52 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:21:52 INFO - Running setup.py install for pep8 17:21:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:21:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:21:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:21:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:21:52 INFO - no previously-included directories found matching 'docs/_build' 17:21:52 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 17:21:52 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:21:52 INFO - Cleaning up... 17:21:52 INFO - Return code: 0 17:21:52 INFO - Running post-action listener: _resource_record_post_action 17:21:52 INFO - Running post-action listener: _start_resource_monitoring 17:21:52 INFO - Starting resource monitoring. 17:21:52 INFO - ##### 17:21:52 INFO - ##### Running install step. 17:21:52 INFO - ##### 17:21:52 INFO - Running pre-action listener: _resource_record_pre_action 17:21:52 INFO - Running main action method: install 17:21:52 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:21:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:21:53 INFO - Reading from file tmpfile_stdout 17:21:53 INFO - Detecting whether we're running mozinstall >=1.0... 17:21:53 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 17:21:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 17:21:53 INFO - Reading from file tmpfile_stdout 17:21:53 INFO - Output received: 17:21:53 INFO - Usage: mozinstall [options] installer 17:21:53 INFO - Options: 17:21:53 INFO - -h, --help show this help message and exit 17:21:53 INFO - -d DEST, --destination=DEST 17:21:53 INFO - Directory to install application into. [default: 17:21:53 INFO - "/builds/slave/test-pgo"] 17:21:53 INFO - --app=APP Application being installed. [default: firefox] 17:21:53 INFO - mkdir: /builds/slave/test-pgo/build/application 17:21:53 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 17:21:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 17:22:09 INFO - Reading from file tmpfile_stdout 17:22:09 INFO - Output received: 17:22:09 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 17:22:09 INFO - Running post-action listener: _resource_record_post_action 17:22:09 INFO - ##### 17:22:09 INFO - ##### Running run-tests step. 17:22:09 INFO - ##### 17:22:09 INFO - Running pre-action listener: _resource_record_pre_action 17:22:09 INFO - Running main action method: run_tests 17:22:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 17:22:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 17:22:09 INFO - Python 2.7.3 17:22:09 INFO - Return code: 0 17:22:09 INFO - grabbing minidump binary from tooltool 17:22:09 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')]} 17:22:09 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 0x14248c0>, '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 0x14257c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1425c50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 17:22:09 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 17:22:09 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 17:22:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:22:09 INFO - Return code: 0 17:22:09 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 17:22:09 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 17:22:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 17:22:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 17:22:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 17:22:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 17:22:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 17:22:10 INFO - Return code: 0 17:22:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dtI9QKRQQ2mp1iScemiuEw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 17:22:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dtI9QKRQQ2mp1iScemiuEw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --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 17:22:10 INFO - Using env: {'DISPLAY': ':0', 17:22:10 INFO - 'HOME': '/home/cltbld', 17:22:10 INFO - 'LANG': 'en_US.UTF-8', 17:22:10 INFO - 'LANGUAGE': 'en_US:en', 17:22:10 INFO - 'LOGNAME': 'cltbld', 17:22:10 INFO - 'MAIL': '/var/mail/cltbld', 17:22:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:22:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 17:22:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:10 INFO - 'MOZ_NO_REMOTE': '1', 17:22:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:22:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:10 INFO - 'NO_EM_RESTART': '1', 17:22:10 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:22:10 INFO - 'PWD': '/builds/slave/test-pgo', 17:22:10 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 17:22:10 INFO - 'SHELL': '/bin/bash', 17:22:10 INFO - 'SHLVL': '1', 17:22:10 INFO - 'TERM': 'linux', 17:22:10 INFO - 'TMOUT': '86400', 17:22:10 INFO - 'USER': 'cltbld', 17:22:10 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1455240070.764407-1476042235', 17:22:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:10 INFO - '_': '/tools/buildbot/bin/python'} 17:22:10 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dtI9QKRQQ2mp1iScemiuEw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 17:22:10 INFO - mozversion application_buildid: 20160211143012 17:22:10 INFO - mozversion application_changeset: f7233ec3a268a519e07cc65f042af59d18375816 17:22:10 INFO - mozversion application_display_name: Nightly 17:22:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:22:10 INFO - mozversion application_name: Firefox 17:22:10 INFO - mozversion application_remotingname: firefox 17:22:10 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 17:22:10 INFO - mozversion application_vendor: Mozilla 17:22:10 INFO - mozversion application_version: 47.0a1 17:22:10 INFO - mozversion platform_buildid: 20160211143012 17:22:10 INFO - mozversion platform_changeset: f7233ec3a268a519e07cc65f042af59d18375816 17:22:10 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 17:22:10 INFO - mozversion platform_version: 47.0a1 17:22:10 INFO - using testdate: 1455240130 17:22:10 INFO - actual date: 1455240130 17:22:10 INFO - starting webserver on 'localhost:53082' 17:22:10 INFO - SUITE-START | Running 2 tests 17:22:10 INFO - TEST-START | dromaeo_css 17:22:10 INFO - operating with platform_type : linux_ 17:22:10 INFO - Initialising browser for dromaeo_css test... 17:22:10 INFO - TEST-INFO | started process 7937 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp6Ay8P7/profile http://localhost:53082/getInfo.html) 17:22:15 INFO - PROCESS | 7937 | __metrics Screen width/height:1600/1200 17:22:15 INFO - PROCESS | 7937 | colorDepth:24 17:22:15 INFO - PROCESS | 7937 | Browser inner width/height: 1024/697 17:22:15 INFO - PROCESS | 7937 | __metrics 17:22:15 INFO - PROCESS | 7937 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:22:16 INFO - TEST-INFO | 7937: exit 0 17:22:16 INFO - Browser initialized. 17:22:16 INFO - Running cycle 1/1 for dromaeo_css test... 17:22:16 INFO - TEST-INFO | started process 8029 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp6Ay8P7/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:22:28 INFO - PROCESS | 8029 | RSS: Main: 150990848 17:22:28 INFO - PROCESS | 8029 | 17:23:19 INFO - PROCESS | 8029 | 1455240199600 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] 17:25:27 INFO - PROCESS | 8029 | Cycle 1(1): loaded http://localhost:53082/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53082/tests/dromaeo/cssquery-ext.html) 17:25:28 INFO - PROCESS | 8029 | RSS: Main: 233418752 17:25:28 INFO - PROCESS | 8029 | 17:28:31 INFO - PROCESS | 8029 | Cycle 1(1): loaded http://localhost:53082/tests/dromaeo/cssquery-ext.html (next: http://localhost:53082/tests/dromaeo/cssquery-jquery.html) 17:28:31 INFO - PROCESS | 8029 | RSS: Main: 236929024 17:28:31 INFO - PROCESS | 8029 | 17:31:33 INFO - PROCESS | 8029 | Cycle 1(1): loaded http://localhost:53082/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53082/tests/dromaeo/cssquery-mootools.html) 17:31:34 INFO - PROCESS | 8029 | RSS: Main: 231321600 17:31:34 INFO - PROCESS | 8029 | 17:34:36 INFO - PROCESS | 8029 | Cycle 1(1): loaded http://localhost:53082/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53082/tests/dromaeo/cssquery-prototype.html) 17:34:36 INFO - PROCESS | 8029 | RSS: Main: 213712896 17:34:36 INFO - PROCESS | 8029 | 17:37:39 INFO - PROCESS | 8029 | Cycle 1(1): loaded http://localhost:53082/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53082/tests/dromaeo/cssquery-yui.html) 17:37:40 INFO - PROCESS | 8029 | RSS: Main: 216637440 17:37:40 INFO - PROCESS | 8029 | 17:40:42 INFO - PROCESS | 8029 | Cycle 1(1): loaded http://localhost:53082/tests/dromaeo/cssquery-yui.html (next: http://localhost:53082/tests/dromaeo/cssquery-dojo.html) 17:40:42 INFO - PROCESS | 8029 | RSS: Main: 281878528 17:40:42 INFO - PROCESS | 8029 | 17:40:42 INFO - PROCESS | 8029 | __start_tp_report 17:40:42 INFO - PROCESS | 8029 | _x_x_mozilla_page_load 17:40:42 INFO - PROCESS | 8029 | _x_x_mozilla_page_load_details 17:40:42 INFO - PROCESS | 8029 | |i|pagename|runs| 17:40:42 INFO - PROCESS | 8029 | |0;dojo.html;3113.5329700544917;3120.1107684309977;3161.5573819665237;3166.414213370527;3195.6325022622405;5019.297298378221;5083;5104.795808167673;5137.1523698589735;5146.922796158051;5057.418396884359;5128;5129.692218466895;5159.1229490986525;5182.689038657673;4686.484486706459;4714.740689262089;4725.952740472603;4749.430068391798;4923.82766603169;4834.0815245103495;4835.347228124193;4875.463698993108;4895.779689913945;4899.8040078396825;4710.22281323583;4715.952840471586;4737.289406589005;4799.544043315879;4827.493113223096;4745.857624271277;4756;4768.73771942543;4795.328653988445;4817.78319975602;4736.976315118402;4744.312074749177;4751.572358487718;4753.263244197155;4756.619470442356;5006.249062640633;5010.949890501085;5060.190369540893;5104.515071068243;5128.71792051437;5602.803901863415;5605.299337582802;5615.550755939515;5619.438056194389;5621.690807005613;5604.3835178130375;5641.407652196543;5657.4908258256955;5660.660360378391;5669.036263835158;5193.844184674465;5292.179712144623;5296;5335.1730481775385;5387.164989426645;5642.520385767174;5647.943520564741;5648.717564121777;5650.943490565041;5686.60193786431;5426.538744206708;5431.755570999315;5432.29380180574;5434;5437.918431223535;5561.805336813192;5579.553635709133;5609.80365687199;5613.354464236583;5654.886902261932;5407.486288802557;5415.079436495726;5428.104362780097;5431.8098866539485;5437.32033495813;5362.812301569505;5455.536279416215;5486.067368547357;5497.862553436116;5577.721113944286;4335.609795118455;4376.256036473807;4381.101874115799;4410.713303635253;4417.4036505072045;3852.460655508231;3889.124946886928;3903.726739128291;3909.863154789569;3929.135590170158;5120.462351453119;5184.326037615086;5207.7916883325;5225;5262.526372626406;5553.666779993213;5583.832485025456;5597.692126932976;5602.803901863415;5629.071203251499;5172.301739265226;5172.379314482211;5177.456367081478;5178.663386879916;5229.320188375563;4631.258998560282;4654.767261636905;4723.220668589713;4764.880877978078;4767.308740232646;5624.55003599711;5634.577406694514;5637.746301416364;5640.85897852557;5641.2384328116;5393.541548968382;5398.3791863934575;5401.432849550741;5435.945640543702;5449.04641687711;5651;5725.599208055396;5820.650760954187;5908;5924.496417804535;5556.888862222814;5558.638688485235;5559.388467268516;5567.109262517978;5567.526760225426;5583.162525621189;5614.185943038155;5622.297212848394;5634.380218175916;5634.718264086698;5397.190421436816;5421.783128674809;5501.312335958005;5523.972380138073;5525.336959564717;5491.450854914477;5498.80754173602;5507.697076660822;5507.779688812563;5509.724513774215;5395.649282796606;5402.297701298806;5402.837914862561;5421.322334708161;5457.481539253765;5305.124654431976;5378.327709036371;5410.918836217538;5503.174523821459;5527.944720552743;5305.389880163676;5342.332208473941;5343.305370301836;5344.171653393731;5378.139497680352 17:40:42 INFO - PROCESS | 8029 | |1;ext.html;520.1911028350918;549.9147632117023;577.2639884147712;579.1746760865765;594.6432140715568;27016.594751078726;35463.645363546355;35757.64242357576;35776.10559736008;35803.4629480558;38295;38860.222795544076;38881.41677874827;38882.22235555287;38886;8394.832103357929;8560.571971401436;8618.698345557907;8624;8628.050914399411;8629.65481380744;8828.117188281152;8847.20375166235;8847.33644976626;8848.469091854477;8725.214730674237;8867.024627290994;8873.733787986339;8879.200871921526;8883.333749968746;8750.431221970583;8804.163604457566;8808.383413161082;8822.382433229677;8823.55882205887;8670.913290867074;8825;8844.11558844117;8847.646094156225;8848;38687.41968870469;39158.80420597879;39164.412533812014;39230.21539569193;39287.41068883969;3264.05342450689;3357.61387440445;3447.5862896452586;3871.2838124946975;4034.875200023909;28340.716592834015;28406.573901391497;28819.711802881913;28937.565936510968;29240.561391579144;3905.882823515299;3940.527136743609;4004.759714417115;4089.7750623715683;4099.057216840143;263474;266208;266320;266500;267406;49560.75219623879;55020.724896376065;55445.1683224752;55492;56577;52199.217011744855;52209.47790522046;52490.47509524932;52516.21225681618;52553.211701824504;13792.172469651852;13888.097273677178;13923.791143132861;13990.370433330525;13992.09051411655;10290.485475726184;11403.258788178742;11582.6525204244;11629.418529073513;11630.302181868945;17672.646547068987;17703.93776373422;17771;17816.91091544534;17820.732689009674;7150.5352152109945;7263.401638323851;7446.755349450761;7462.440316976248;7518.548887066793;969.1132613658565;983.5573991703762;1065.9819872022201;1133.2520536445907;1243.5461056714414;26509;26656.466870662865;26741.331466713098;26828;27049.86475067612;981.617169303972;1083.1226706367868;1085.8208395614636;1119.874526101263;1191.4459776204108;13374.39815208318;13639.659008524668;15629.68740625181;16132.354705811636;16243.745978221355;296781;298978;299412;299454;301125;51165.74417127965;51494.485055149715;51533.48466515362;51547.22679159816;51671.22493162606;1333.8866196373224;1354.4988354308969;1357.606294174698;1373.7595920713836;1382.3641125082574;25844.48311033731;26166.73833261643;26268.73731262663;26465.470690586466;26486.470270594866;39042;39224;39379.21241575095;39406.99999999885;39472.21055578815;275618;295359;300894;301051;301072;27301.726982729917;27791.58312625353;27954.58068128939;27971;27974.741136649307;37365.43951840779;38083.238335232585;38433;38648.80675596604;38992.415113772746;31603.683963160074;31717.36565268728;32584;32966.34067318688;35054.824725876206;34263;34888.47667284942;35020;35660;35899;36117.27765444624;36390.63609363873;36897.26205475822;37358.813205933795;37423.812880935424;26840.463190736467;27958.860205698842;29143.85428072931;29505.11484655464;30992.380152397276;24457.26628201157;24765.25704228876;24816.379590510383;25143.35994720528;25246.747532525176 17:40:42 INFO - PROCESS | 8029 | |2;jquery.html;346.9902583482068;354.9609542950275;358.51063298597404;358.82238292045434;363.8762820640982;13815.309234538283;14190.065967031283;16315.510534683963;16772.1613919304;17375.783695141345;15851.445199418024;16393.508194754148;16886.83113168868;16931.3227470901;16942.407015754452;5309.0709125903;5523.502884740373;5523.889522209573;5527.309086364205;5531.529819965308;4019.8191081401405;5438.700871452069;5478.808241711541;5793.102069179284;6030.366811484775;5822.359540450547;5934.495567876714;5985.683149707057;5994.190784244115;5999.220101386813;6069.484093852028;6069.635821850703;6073.453389194994;6103.176071230394;6106.419890110455;5186.740662966874;5231.503007214308;5247.632665713401;5331.040412725708;5332.706701131437;19192.61614767711;19835.80164198354;19846.404607861787;19947.700784488243;20050.398488045383;2183.9017244224046;2264.9433764155865;2595.4290056187797;2865.398266364066;2904.7966642335045;12478;12612.747745045139;12892.226466411952;12972.156809807333;13436.865631343659;1835.807240239769;1900.5628705397698;1909.5321646196633;1919.4913347962802;1938.6510428122933;56520;56548.71725641345;57232.42767572313;57622;58186.127208091486;9260.768480788034;9635.373700709431;9643.99999999986;9666.64666946628;9714.514274286257;12584.622461326175;12643.11498195136;12664.303463309423;12720.173188742701;12769.489220431264;7317;7321.828219028157;7362.411007119417;7401.185869554345;7418.517796343221;7112.964435177894;7126.251743566954;7171.533850299714;7185.892211616725;7190.856182876313;5143.537081662668;5778.739956701958;5851.795187168429;5881.470667639933;5888.440598143169;1686.5024817678814;1730.6019615488508;1731.1344327836082;1750.1861634340094;1782.08222765276;449.77736020669323;463.6684770389188;483;485.5484399508491;983.2920297385871;10968.890311096946;11183;11367.488463019185;11376.431178441046;11791.174617776673;479.09451137350436;485.20426500539145;490.35518293444005;493.543472288132;494.2882249560621;5961.857626983914;6370.840728981812;6388.7125079371535;6394.616323020634;6403.807885763435;521989;527998;536224;541808;544941;68042.3195768036;74635;77620;79300;80708;469.1157168736887;484.63894398673216;506.05367961911463;519.5220397234554;522.3340241192434;10159.847602285823;10452.529636166542;10666.306690065121;10714.19643526723;11029.61396351156;33892.49161262534;34011.31977360488;34117.147071323416;35150;37092.62907371;43367.78316108399;43744.562554374046;44472.33291500695;44787.328190077824;45194.54805451904;7047.260037695968;7101.857962840818;7369.557826530426;7421.554706717614;7538.886916696364;8109;9255.76860578464;9273.67542136022;10922.836157457803;11381.879594675407;3193.9840300798346;6666;7892.85553594737;9616.567254473426;10340.172786177238;9937.453440060577;9981.301308908307;10230.181585472996;10307.845382319121;10422.166226701695;7476.70093196266;8804.339674524308;9546.379485333431;9851.359661621971;10308.381497110197;7400.333969942731;7412.814679633052;7444.181140074696;7474.850502990019;7479.326860582573;8554.957225213833;9176.587053582738;10465.319754215952;10669.41318227505;10839.241253112521 17:40:42 INFO - PROCESS | 8029 | |3;mootools.html;1281.4361680860427;1422.7581311177098;1430.1776478524848;1589.745640697488;1772.1227992143884;7137.2505886881845;7670.53976761394;7747.690092396311;7770.4560680752365;7814;7679.155292917789;7873.8818917716135;7880.921190788091;7892.447528672995;7895.486793358442;1902.5243689077731;1950.1711772496703;2140.646793279107;2219.345293138528;2240.2271216430386;2200.3398980305924;2205.1620384254043;2205.9227927022557;2207.0509680837235;2207.073029327686;2088.8955552222405;2199.1643175593254;2203.9779602203935;2213.900374483144;2217.7116974793253;2202.90086946087;2214.900329485169;2232.229880691159;2253.5605556916407;2264.8188144948363;2178.1505212966954;2205.757366689663;2206.724159480065;2208.7791220877943;2226.810721088709;7992.760217193493;8014.959925200336;8047.39644526657;8055.275025247697;8070.596470176526;4633.0733853229485;4788;4789.976050119727;4790.377250957354;4795.808167673289;2966.2287805170813;3043.269615292336;3062.98921355952;3085.1361618746787;3093.6287645482685;943.7357539888842;961.624966263158;963.2053555816409;979.5934687104843;1010.4038617215805;11010.669679909615;11040.447977601169;11063.778724425467;11065.668029959113;11087.72280692989;4064.6545043671026;4163.167366526707;4218.8523401680795;4245.150969806051;4251.149770046003;9005.594748236344;9013.819723605491;9025.323100767337;9026.593803278869;9030.683926062688;4787.952120478821;4795.664303498722;4797.95202047982;4799;4807.495213002654;4448.088141930896;4453.888652783707;4458.197524445566;4458.598726114666;4461.286194208911;3135.604655928136;3176.3964846679055;3476.5480487536456;3490.7905525668543;3522.647735226457;1119.4906317625462;1132.3432409202642;1133.8639363276295;1152.9596464123715;1157.6469176900957;1339.6650837290676;1381.7650999330137;1396.923169225682;1404.4382247101241;1406.367134789349;7345.375643070292;7498.475106742476;7535.208803075708;7559.697612095564;7625.580593067323;1134.126722423729;1137.38581166171;1147.6212849759559;1152.1128730877178;1166.1894982986744;5874.618149820248;5915.438033386821;5940.257467816523;5944.286685597669;5956.55325850563;9291.349605527548;9672.95163524178;9674.70975870725;9800.068993445611;9805.656802011896;9626.229901607854;9715.07706767856;9716.708498745049;9734.805303893883;9748.512574371252;7307.07716913239;7517.210692877278;7601.809954751176;7661;7672.388798352297;7129.679164437509;7295.124585049828;7310.049693539806;7310.853782924418;7323.231060738546;8381.664733410595;8513.148685131437;8734.65061397537;8756.4308319959;8760.78098047554;8767.123287671182;8905.866412003696;8913.910860891567;9039.728808135766;9042.231410330196;6915.239323674492;6968.651567421507;7002.404795592432;7012.4390048796995;7013.614251216232;6849.4177994871;7253.637318134178;7415.4809163360205;7422.554646721214;7432;6959.547629404073;7050.823729406806;7076.752313668997;7088.645567721696;7096.219415864354;7086.574805511686;7091.64541772899;7097.609631470112;7115.039469671528;7208.531445456028;7075.929240707733;7101.82245443868;7140.2859714030255;7142.214356420894;7152.9284707152265;6551.770688025897;6557.639329836905;6592.71442068792;6601.207855057424;6610.206775186816;6574.671266436755;6641.900371494335;6644.734210631521;6758.898616520854;6766.729330826909 17:40:42 INFO - PROCESS | 8029 | |4;prototype.html;330.2981165024322;333.36493978970066;336.50197707393056;336.63306995375035;344.47811565478287;5613.46672066154;5711.114777209539;5755.971220143899;5815.854603634906;5821.563382746295;5514.5864060195445;5610.186522954169;5638.182463542794;5668.376478587352;5703.3441154267275;4423.933640995388;4440.467143942723;4455.777211139446;4465.598096171344;4466.441694788152;4259.659227261827;4349.521552629209;4457.08629730906;4460.264056430685;4470.664700147486;4432.556744325574;4443.089166720831;4454.665900057508;4457.1977044132045;4463.776811159445;4430.291153415455;4441.666874984389;4442.178197033543;4443.7111587746695;4445.933311000337;3936.252112098692;3936.5866584008554;3938.9409158862354;3942.073612701042;3946.7039972002217;5312.946870531284;5484;5484.095124304485;5491.560675145979;5515.283013208257;5124.897502049938;5127.846164615067;5130.615203859688;5136.717480538568;5143;6113.174721412597;6113.358097399753;6115.388461153893;6115.4801841843055;6123.418275263843;4055.6349928506575;4130.6282434581035;4209.3896385024;4229.661627069827;4241.533431322583;6244.313125556185;6330.9683451582905;6336.588121772116;6347.143135676671;6357.554971152022;4333.934990975138;4335.869923902288;4337.609615134653;4338.587834155814;4340.82636694535;4307.719998200169;4386.780660966939;4387.012922092504;4390.8024138913825;4392.494863090722;5081.593472522263;5098.158803797406;5098.9490105098475;5101.234814777738;5104.744762761847;6099.817005489843;6114.48026917717;6116.480099191618;6117.571769976059;6130.754769809158;1517.4233791159288;1553.8523840235387;1554.4093244567218;1556.3152213026458;1558.9766153507705;1021.9131373833308;1027.209049032241;1041.6093964763213;1044.5717255925035;1045.7856139491387;5797.4782269595935;5825.2135961644635;5828.562857785683;5831.446012628793;5837.124431335334;6257.0614407838275;6265.530085243625;6273.404026617464;6273.498120150377;6281;5799.710014499258;5804.129380592861;5812.331581868055;5812.59311848175;5822.534197264209;3266.281418088017;3373.9325213495595;3381.391349557054;3384.1201287665385;3385.932281354359;6541.803745887631;6593.274739778621;6614.966925165343;6623;6625.271220165778;6436.356364363526;6455.289918109004;6469.094326794253;6472.029195620695;6477.838054048687;6434.002537796416;6475.740970361227;6529.2817790043055;6541.084248205255;6543.345665433419;6264.590467144856;6268.529860260407;6271.874562508816;6273.215848018997;6273.749050037947;6051.576389652682;6072.605280656743;6192.256929168529;6240.720652266184;6275.152854364603;6576.638284894377;6590.505712071518;6600.372964568358;6606;6624.8343791405605;4231.9576804231565;4245.341971994346;4248.383984322318;4250.107477429774;4253.106847562047;6204.5967012144065;6329.7151628175925;6350.333215012542;6355.269144048309;6357.745690172342;6163.722632481459;6164.075388691732;6169.876602468015;6174.938250617616;6183.938160618336;6159.938400615936;6165.075238714228;6167.722452489559;6169.043798211284;6169.383061693795;5897.997340452048;5991.2510936132985;6042.335343112166;6042.607230530001;6053.969730151321;6129.724162412613;6192.182556936493;6203.844903877439;6206.255249369924;6210.689465526615;6011.489023433057;6058.545609079249;6075.422834830684;6075.939240607538;6076.0278355462915 17:40:42 INFO - PROCESS | 8029 | |5;yui.html;708.1396103733962;763.4960925788977;774.1136398823347;785.3246208260891;804.8229389534303;12840.293783841886;13046.217226966388;13058.2817945013;13094.279814610192;13107.213567185963;12542.874571254284;12985.870141298585;13092.934535327335;13106.213627182377;13109.672258193526;677.7085853083172;693.6705065094066;810.5825499867573;825.6037102190952;825.9421840471169;800.1358532784578;816.1512027491402;819.9877001844977;822.4777266435826;822.5393779483478;862.3790870573177;868.3487384461654;868.8349213649418;869.7564681889081;869.8390797702414;699.3426179391381;710.8187412209879;711.9252478489788;712.5582139073756;861.8707193920931;616.4205646692095;622.107276058857;626.4393367935672;626.683524819963;626.9310375858652;12897.355132243445;12944.741105177938;12945.482180712761;13015;13017.349132543335;11823.645290641294;12006.459709313101;12037.87962120385;12303.384830758516;12682.239065656091;10227.130693891027;10371.844422333672;10435.686929392054;10501.474926253657;10630.681079567625;3497.3189546913177;3519.753617246794;3536.752427330088;3574.3566158091535;3622.855085796565;47829.28256076162;48083.75958120187;48139.27791083136;48202.517974820155;49615.25577116346;9442.433453992782;9554.235661147091;9891.554880030415;9952.281538920284;10058.497075146213;18064.458066258034;18067.63864722698;18068.63862722738;18071.819281807013;18085.276588936296;7167.247439018828;7232.963835180895;7249.456290778213;7466.477346585795;7613.238676132453;3862.806859657006;3916.96083039166;3939.881803545898;3990.7206495545033;4014.157027024299;3025.3041800385595;3044.512877939519;3044.710752478511;3056.862441190152;3062.7090426409454;554.2296208270507;565.8472212502601;566.153600367445;569.2514343638103;580.7647902599454;402.28594245214975;404.41360027959576;510.4308695804226;533.4398881174751;550.2983695787823;7686.501132279263;7825.960870195612;7949.364050875916;7959.742912660034;8205.179482051746;545.4082320682104;586.1939832729996;591.5622439394817;593.3502814418205;597.9820605381846;3572.7677700949357;3782.205736795249;3796.52543432071;3850.5571859236547;3919.3729003359326;52444.21333679998;53117.468825311254;53323;53458.732706336996;54025.459745402826;47369.52630473651;47515.28727069097;48105.75947120242;48591.27113093236;48606.681131452686;43203.56796432058;43523.12953740908;43733.78133109378;43946.560534394244;44161.77919110384;7410.740624078131;7440.255974402517;7667.923320766721;7708.576028318496;7900.209979002054;28279.858600706866;32179.35641287208;32947.176320592174;32974.34051318912;33094.17264568405;38778;41918.790406047774;42077.15845683008;42218.36672449854;42329;9622.855657165288;9743.610255589698;9745.463999480096;9964.903860575187;9969.252306077218;10123.139533139765;10261.281710280507;10307.184564610236;10368.688939331832;10663.880292569169;9775.853362199716;9987.350822196535;10044.698659040241;10345.224108191765;10359.741006474898;8997.64009439615;9293;9436.150746432853;9442.197413219954;9457.054294570764;10475.738106547396;10485.580576776843;10844.40355780408;10889.618863339745;11023.44882755843;8714.738557843275;8734.882888970616;8821.823563528566;8846.646134154562;9051.683191088281;7992.560409177551;8552.444091134057;8762.430442021248;8779.341549383695;8878.245349145394 17:40:42 INFO - PROCESS | 8029 | __end_tp_report 17:40:42 INFO - PROCESS | 8029 | __start_cc_report 17:40:42 INFO - PROCESS | 8029 | _x_x_mozilla_cycle_collect,936 17:40:42 INFO - PROCESS | 8029 | __end_cc_report 17:40:42 INFO - PROCESS | 8029 | __startTimestamp1455241242856__endTimestamp 17:40:42 INFO - PROCESS | 8029 | 17:40:42 INFO - PROCESS | 8029 | ------- Summary: start ------- 17:40:42 INFO - PROCESS | 8029 | Number of tests: 6 17:40:42 INFO - PROCESS | 8029 | 17:40:42 INFO - PROCESS | 8029 | [#0] dojo.html Cycles:165 Average:5171.92 Median:5387.16 stddev:553.02 (10.3%) stddev-sans-first:530.61 17:40:42 INFO - PROCESS | 8029 | Values: 3113.5 3120.1 3161.6 3166.4 3195.6 5019.3 5083.0 5104.8 5137.2 5146.9 5057.4 5128.0 5129.7 5159.1 5182.7 4686.5 4714.7 4726.0 4749.4 4923.8 4834.1 4835.3 4875.5 4895.8 4899.8 4710.2 4716.0 4737.3 4799.5 4827.5 4745.9 4756.0 4768.7 4795.3 4817.8 4737.0 4744.3 4751.6 4753.3 4756.6 5006.2 5010.9 5060.2 5104.5 5128.7 5602.8 5605.3 5615.6 5619.4 5621.7 5604.4 5641.4 5657.5 5660.7 5669.0 5193.8 5292.2 5296.0 5335.2 5387.2 5642.5 5647.9 5648.7 5650.9 5686.6 5426.5 5431.8 5432.3 5434.0 5437.9 5561.8 5579.6 5609.8 5613.4 5654.9 5407.5 5415.1 5428.1 5431.8 5437.3 5362.8 5455.5 5486.1 5497.9 5577.7 4335.6 4376.3 4381.1 4410.7 4417.4 3852.5 3889.1 3903.7 3909.9 3929.1 5120.5 5184.3 5207.8 5225.0 5262.5 5553.7 5583.8 5597.7 5602.8 5629.1 5172.3 5172.4 5177.5 5178.7 5229.3 4631.3 4654.8 4723.2 4764.9 4767.3 5624.6 5634.6 5637.7 5640.9 5641.2 5393.5 5398.4 5401.4 5435.9 5449.0 5651.0 5725.6 5820.7 5908.0 5924.5 5556.9 5558.6 5559.4 5567.1 5567.5 5583.2 5614.2 5622.3 5634.4 5634.7 5397.2 5421.8 5501.3 5524.0 5525.3 5491.5 5498.8 5507.7 5507.8 5509.7 5395.6 5402.3 5402.8 5421.3 5457.5 5305.1 5378.3 5410.9 5503.2 5527.9 5305.4 5342.3 5343.3 5344.2 5378.1 17:40:42 INFO - PROCESS | 8029 | 17:40:42 INFO - PROCESS | 8029 | [#1] ext.html Cycles:180 Average:44350.90 Median:35708.82 stddev:75017.70 (210.1%) stddev-sans-first:75155.95 17:40:42 INFO - PROCESS | 8029 | Values: 520.2 549.9 577.3 579.2 594.6 27016.6 35463.6 35757.6 35776.1 35803.5 38295.0 38860.2 38881.4 38882.2 38886.0 8394.8 8560.6 8618.7 8624.0 8628.1 8629.7 8828.1 8847.2 8847.3 8848.5 8725.2 8867.0 8873.7 8879.2 8883.3 8750.4 8804.2 8808.4 8822.4 8823.6 8670.9 8825.0 8844.1 8847.6 8848.0 38687.4 39158.8 39164.4 39230.2 39287.4 3264.1 3357.6 3447.6 3871.3 4034.9 28340.7 28406.6 28819.7 28937.6 29240.6 3905.9 3940.5 4004.8 4089.8 4099.1 263474.0 266208.0 266320.0 266500.0 267406.0 49560.8 55020.7 55445.2 55492.0 56577.0 52199.2 52209.5 52490.5 52516.2 52553.2 13792.2 13888.1 13923.8 13990.4 13992.1 10290.5 11403.3 11582.7 11629.4 11630.3 17672.6 17703.9 17771.0 17816.9 17820.7 7150.5 7263.4 7446.8 7462.4 7518.5 969.1 983.6 1066.0 1133.3 1243.5 26509.0 26656.5 26741.3 26828.0 27049.9 981.6 1083.1 1085.8 1119.9 1191.4 13374.4 13639.7 15629.7 16132.4 16243.7 296781.0 298978.0 299412.0 299454.0 301125.0 51165.7 51494.5 51533.5 51547.2 51671.2 1333.9 1354.5 1357.6 1373.8 1382.4 25844.5 26166.7 26268.7 26465.5 26486.5 39042.0 39224.0 39379.2 39407.0 39472.2 275618.0 295359.0 300894.0 301051.0 301072.0 27301.7 27791.6 27954.6 27971.0 27974.7 37365.4 38083.2 38433.0 38648.8 38992.4 31603.7 31717.4 32584.0 32966.3 35054.8 34263.0 34888.5 35020.0 35660.0 35899.0 36117.3 36390.6 36897.3 37358.8 37423.8 26840.5 27958.9 29143.9 29505.1 30992.4 24457.3 24765.3 24816.4 25143.4 25246.7 17:40:42 INFO - PROCESS | 8029 | 17:40:42 INFO - PROCESS | 8029 | [#2] jquery.html Cycles:180 Average:27232.22 Median:2853.13 stddev:87470.50 (3065.8%) stddev-sans-first:87692.58 17:40:42 INFO - PROCESS | 8029 | Values: 347.0 355.0 358.5 358.8 363.9 13815.3 14190.1 16315.5 16772.2 17375.8 15851.4 16393.5 16886.8 16931.3 16942.4 5309.1 5523.5 5523.9 5527.3 5531.5 4019.8 5438.7 5478.8 5793.1 6030.4 5822.4 5934.5 5985.7 5994.2 5999.2 6069.5 6069.6 6073.5 6103.2 6106.4 5186.7 5231.5 5247.6 5331.0 5332.7 19192.6 19835.8 19846.4 19947.7 20050.4 2183.9 2264.9 2595.4 2865.4 2904.8 12478.0 12612.7 12892.2 12972.2 13436.9 1835.8 1900.6 1909.5 1919.5 1938.7 56520.0 56548.7 57232.4 57622.0 58186.1 9260.8 9635.4 9644.0 9666.6 9714.5 12584.6 12643.1 12664.3 12720.2 12769.5 7317.0 7321.8 7362.4 7401.2 7418.5 7113.0 7126.3 7171.5 7185.9 7190.9 5143.5 5778.7 5851.8 5881.5 5888.4 1686.5 1730.6 1731.1 1750.2 1782.1 449.8 463.7 483.0 485.5 983.3 10968.9 11183.0 11367.5 11376.4 11791.2 479.1 485.2 490.4 493.5 494.3 5961.9 6370.8 6388.7 6394.6 6403.8 521989.0 527998.0 536224.0 541808.0 544941.0 68042.3 74635.0 77620.0 79300.0 80708.0 469.1 484.6 506.1 519.5 522.3 10159.8 10452.5 10666.3 10714.2 11029.6 33892.5 34011.3 34117.1 35150.0 37092.6 43367.8 43744.6 44472.3 44787.3 45194.5 7047.3 7101.9 7369.6 7421.6 7538.9 8109.0 9255.8 9273.7 10922.8 11381.9 3194.0 6666.0 7892.9 9616.6 10340.2 9937.5 9981.3 10230.2 10307.8 10422.2 7476.7 8804.3 9546.4 9851.4 10308.4 7400.3 7412.8 7444.2 7474.9 7479.3 8555.0 9176.6 10465.3 10669.4 10839.2 17:40:42 INFO - PROCESS | 8029 | 17:40:42 INFO - PROCESS | 8029 | [#3] mootools.html Cycles:180 Average:5534.92 Median:6605.71 stddev:2916.33 (44.1%) stddev-sans-first:2906.98 17:40:42 INFO - PROCESS | 8029 | Values: 1281.4 1422.8 1430.2 1589.7 1772.1 7137.3 7670.5 7747.7 7770.5 7814.0 7679.2 7873.9 7880.9 7892.4 7895.5 1902.5 1950.2 2140.6 2219.3 2240.2 2200.3 2205.2 2205.9 2207.1 2207.1 2088.9 2199.2 2204.0 2213.9 2217.7 2202.9 2214.9 2232.2 2253.6 2264.8 2178.2 2205.8 2206.7 2208.8 2226.8 7992.8 8015.0 8047.4 8055.3 8070.6 4633.1 4788.0 4790.0 4790.4 4795.8 2966.2 3043.3 3063.0 3085.1 3093.6 943.7 961.6 963.2 979.6 1010.4 11010.7 11040.4 11063.8 11065.7 11087.7 4064.7 4163.2 4218.9 4245.2 4251.1 9005.6 9013.8 9025.3 9026.6 9030.7 4788.0 4795.7 4798.0 4799.0 4807.5 4448.1 4453.9 4458.2 4458.6 4461.3 3135.6 3176.4 3476.5 3490.8 3522.6 1119.5 1132.3 1133.9 1153.0 1157.6 1339.7 1381.8 1396.9 1404.4 1406.4 7345.4 7498.5 7535.2 7559.7 7625.6 1134.1 1137.4 1147.6 1152.1 1166.2 5874.6 5915.4 5940.3 5944.3 5956.6 9291.3 9673.0 9674.7 9800.1 9805.7 9626.2 9715.1 9716.7 9734.8 9748.5 7307.1 7517.2 7601.8 7661.0 7672.4 7129.7 7295.1 7310.0 7310.9 7323.2 8381.7 8513.1 8734.7 8756.4 8760.8 8767.1 8905.9 8913.9 9039.7 9042.2 6915.2 6968.7 7002.4 7012.4 7013.6 6849.4 7253.6 7415.5 7422.6 7432.0 6959.5 7050.8 7076.8 7088.6 7096.2 7086.6 7091.6 7097.6 7115.0 7208.5 7075.9 7101.8 7140.3 7142.2 7152.9 6551.8 6557.6 6592.7 6601.2 6610.2 6574.7 6641.9 6644.7 6758.9 6766.7 17:40:42 INFO - PROCESS | 8029 | 17:40:42 INFO - PROCESS | 8029 | [#4] prototype.html Cycles:180 Average:5114.46 Median:5808.23 stddev:1541.11 (26.5%) stddev-sans-first:1503.02 17:40:42 INFO - PROCESS | 8029 | Values: 330.3 333.4 336.5 336.6 344.5 5613.5 5711.1 5756.0 5815.9 5821.6 5514.6 5610.2 5638.2 5668.4 5703.3 4423.9 4440.5 4455.8 4465.6 4466.4 4259.7 4349.5 4457.1 4460.3 4470.7 4432.6 4443.1 4454.7 4457.2 4463.8 4430.3 4441.7 4442.2 4443.7 4445.9 3936.3 3936.6 3938.9 3942.1 3946.7 5312.9 5484.0 5484.1 5491.6 5515.3 5124.9 5127.8 5130.6 5136.7 5143.0 6113.2 6113.4 6115.4 6115.5 6123.4 4055.6 4130.6 4209.4 4229.7 4241.5 6244.3 6331.0 6336.6 6347.1 6357.6 4333.9 4335.9 4337.6 4338.6 4340.8 4307.7 4386.8 4387.0 4390.8 4392.5 5081.6 5098.2 5098.9 5101.2 5104.7 6099.8 6114.5 6116.5 6117.6 6130.8 1517.4 1553.9 1554.4 1556.3 1559.0 1021.9 1027.2 1041.6 1044.6 1045.8 5797.5 5825.2 5828.6 5831.4 5837.1 6257.1 6265.5 6273.4 6273.5 6281.0 5799.7 5804.1 5812.3 5812.6 5822.5 3266.3 3373.9 3381.4 3384.1 3385.9 6541.8 6593.3 6615.0 6623.0 6625.3 6436.4 6455.3 6469.1 6472.0 6477.8 6434.0 6475.7 6529.3 6541.1 6543.3 6264.6 6268.5 6271.9 6273.2 6273.7 6051.6 6072.6 6192.3 6240.7 6275.2 6576.6 6590.5 6600.4 6606.0 6624.8 4232.0 4245.3 4248.4 4250.1 4253.1 6204.6 6329.7 6350.3 6355.3 6357.7 6163.7 6164.1 6169.9 6174.9 6183.9 6159.9 6165.1 6167.7 6169.0 6169.4 5898.0 5991.3 6042.3 6042.6 6054.0 6129.7 6192.2 6203.8 6206.3 6210.7 6011.5 6058.5 6075.4 6075.9 6076.0 17:40:42 INFO - PROCESS | 8029 | 17:40:42 INFO - PROCESS | 8029 | [#5] yui.html Cycles:180 Average:12982.27 Median:25062.84 stddev:15086.87 (60.2%) stddev-sans-first:15101.04 17:40:42 INFO - PROCESS | 8029 | Values: 708.1 763.5 774.1 785.3 804.8 12840.3 13046.2 13058.3 13094.3 13107.2 12542.9 12985.9 13092.9 13106.2 13109.7 677.7 693.7 810.6 825.6 825.9 800.1 816.2 820.0 822.5 822.5 862.4 868.3 868.8 869.8 869.8 699.3 710.8 711.9 712.6 861.9 616.4 622.1 626.4 626.7 626.9 12897.4 12944.7 12945.5 13015.0 13017.3 11823.6 12006.5 12037.9 12303.4 12682.2 10227.1 10371.8 10435.7 10501.5 10630.7 3497.3 3519.8 3536.8 3574.4 3622.9 47829.3 48083.8 48139.3 48202.5 49615.3 9442.4 9554.2 9891.6 9952.3 10058.5 18064.5 18067.6 18068.6 18071.8 18085.3 7167.2 7233.0 7249.5 7466.5 7613.2 3862.8 3917.0 3939.9 3990.7 4014.2 3025.3 3044.5 3044.7 3056.9 3062.7 554.2 565.8 566.2 569.3 580.8 402.3 404.4 510.4 533.4 550.3 7686.5 7826.0 7949.4 7959.7 8205.2 545.4 586.2 591.6 593.4 598.0 3572.8 3782.2 3796.5 3850.6 3919.4 52444.2 53117.5 53323.0 53458.7 54025.5 47369.5 47515.3 48105.8 48591.3 48606.7 43203.6 43523.1 43733.8 43946.6 44161.8 7410.7 7440.3 7667.9 7708.6 7900.2 28279.9 32179.4 32947.2 32974.3 33094.2 38778.0 41918.8 42077.2 42218.4 42329.0 9622.9 9743.6 9745.5 9964.9 9969.3 10123.1 10261.3 10307.2 10368.7 10663.9 9775.9 9987.4 10044.7 10345.2 10359.7 8997.6 9293.0 9436.2 9442.2 9457.1 10475.7 10485.6 10844.4 10889.6 11023.4 8714.7 8734.9 8821.8 8846.6 9051.7 7992.6 8552.4 8762.4 8779.3 8878.2 17:40:42 INFO - PROCESS | 8029 | -------- Summary: end -------- 17:40:42 INFO - PROCESS | 8029 | 17:40:43 INFO - TEST-INFO | 8029: exit 0 17:40:43 INFO - TEST-OK | dromaeo_css | took 1112742ms 17:40:43 INFO - TEST-START | kraken 17:40:43 INFO - operating with platform_type : linux_ 17:40:43 INFO - Initialising browser for kraken test... 17:40:43 INFO - TEST-INFO | started process 8213 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpg9yRmN/profile http://localhost:53082/getInfo.html) 17:40:47 INFO - PROCESS | 8213 | __metrics Screen width/height:1600/1200 17:40:47 INFO - PROCESS | 8213 | colorDepth:24 17:40:47 INFO - PROCESS | 8213 | Browser inner width/height: 1024/697 17:40:47 INFO - PROCESS | 8213 | __metrics 17:40:47 INFO - PROCESS | 8213 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:40:48 INFO - TEST-INFO | 8213: exit 0 17:40:48 INFO - Browser initialized. 17:40:48 INFO - Running cycle 1/1 for kraken test... 17:40:48 INFO - TEST-INFO | started process 8298 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpg9yRmN/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:41:00 INFO - PROCESS | 8298 | RSS: Main: 152186880 17:41:00 INFO - PROCESS | 8298 | 17:41:02 INFO - PROCESS | 8298 | Cycle 1(1): loaded http://localhost:53082/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53082/tests/kraken/driver.html?testName=audio-beat-detection) 17:41:03 INFO - PROCESS | 8298 | RSS: Main: 194248704 17:41:03 INFO - PROCESS | 8298 | 17:41:06 INFO - PROCESS | 8298 | Cycle 1(1): loaded http://localhost:53082/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53082/tests/kraken/driver.html?testName=audio-dft) 17:41:06 INFO - PROCESS | 8298 | RSS: Main: 182870016 17:41:06 INFO - PROCESS | 8298 | 17:41:09 INFO - PROCESS | 8298 | Cycle 1(1): loaded http://localhost:53082/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53082/tests/kraken/driver.html?testName=audio-fft) 17:41:10 INFO - PROCESS | 8298 | RSS: Main: 166543360 17:41:10 INFO - PROCESS | 8298 | 17:41:12 INFO - PROCESS | 8298 | Cycle 1(1): loaded http://localhost:53082/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53082/tests/kraken/driver.html?testName=audio-oscillator) 17:41:12 INFO - PROCESS | 8298 | RSS: Main: 169893888 17:41:12 INFO - PROCESS | 8298 | 17:41:15 INFO - PROCESS | 8298 | Cycle 1(1): loaded http://localhost:53082/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53082/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:41:15 INFO - PROCESS | 8298 | RSS: Main: 171593728 17:41:15 INFO - PROCESS | 8298 | 17:41:18 INFO - PROCESS | 8298 | Cycle 1(1): loaded http://localhost:53082/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53082/tests/kraken/driver.html?testName=imaging-darkroom) 17:41:19 INFO - PROCESS | 8298 | RSS: Main: 172171264 17:41:19 INFO - PROCESS | 8298 | 17:41:22 INFO - PROCESS | 8298 | Cycle 1(1): loaded http://localhost:53082/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53082/tests/kraken/driver.html?testName=imaging-desaturate) 17:41:23 INFO - PROCESS | 8298 | RSS: Main: 170758144 17:41:23 INFO - PROCESS | 8298 | 17:41:25 INFO - PROCESS | 8298 | Cycle 1(1): loaded http://localhost:53082/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53082/tests/kraken/driver.html?testName=json-parse-financial) 17:41:26 INFO - PROCESS | 8298 | RSS: Main: 171753472 17:41:26 INFO - PROCESS | 8298 | 17:41:27 INFO - PROCESS | 8298 | Cycle 1(1): loaded http://localhost:53082/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53082/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:41:28 INFO - PROCESS | 8298 | RSS: Main: 183115776 17:41:28 INFO - PROCESS | 8298 | 17:41:30 INFO - PROCESS | 8298 | Cycle 1(1): loaded http://localhost:53082/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53082/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:41:30 INFO - PROCESS | 8298 | RSS: Main: 179834880 17:41:30 INFO - PROCESS | 8298 | 17:41:33 INFO - PROCESS | 8298 | Cycle 1(1): loaded http://localhost:53082/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53082/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:41:33 INFO - PROCESS | 8298 | RSS: Main: 190222336 17:41:33 INFO - PROCESS | 8298 | 17:41:36 INFO - PROCESS | 8298 | Cycle 1(1): loaded http://localhost:53082/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53082/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:41:36 INFO - PROCESS | 8298 | RSS: Main: 195346432 17:41:36 INFO - PROCESS | 8298 | 17:41:39 INFO - PROCESS | 8298 | Cycle 1(1): loaded http://localhost:53082/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53082/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:41:39 INFO - PROCESS | 8298 | RSS: Main: 194293760 17:41:39 INFO - PROCESS | 8298 | 17:41:41 INFO - PROCESS | 8298 | Cycle 1(1): loaded http://localhost:53082/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53082/tests/kraken/driver.html?testName=ai-astar) 17:41:41 INFO - PROCESS | 8298 | RSS: Main: 254025728 17:41:41 INFO - PROCESS | 8298 | 17:41:41 INFO - PROCESS | 8298 | __start_tp_report 17:41:41 INFO - PROCESS | 8298 | _x_x_mozilla_page_load 17:41:41 INFO - PROCESS | 8298 | _x_x_mozilla_page_load_details 17:41:41 INFO - PROCESS | 8298 | |i|pagename|runs| 17:41:41 INFO - PROCESS | 8298 | |0;ai-astar;109;110;105;110;111;111;99;110;112;114 17:41:41 INFO - PROCESS | 8298 | |1;audio-beat-detection;157;123;149;164;127;148;151;128;165;126 17:41:41 INFO - PROCESS | 8298 | |2;audio-dft;160;160;161;162;161;162;160;161;163;161 17:41:41 INFO - PROCESS | 8298 | |3;audio-fft;75;74;93;100;74;72;75;117;99;76 17:41:41 INFO - PROCESS | 8298 | |4;audio-oscillator;95;96;140;95;97;96;136;95;95;136 17:41:41 INFO - PROCESS | 8298 | |5;imaging-gaussian-blur;118;115;115;115;115;115;115;115;114;115 17:41:41 INFO - PROCESS | 8298 | |6;imaging-darkroom;145;145;146;145;146;144;145;149;145;145 17:41:41 INFO - PROCESS | 8298 | |7;imaging-desaturate;95;96;96;96;96;96;96;96;96;96 17:41:41 INFO - PROCESS | 8298 | |8;json-parse-financial;58;59;58;57;56;58;57;66;55;54 17:41:41 INFO - PROCESS | 8298 | |9;json-stringify-tinderbox;66;67;66;66;67;67;67;67;66;66 17:41:41 INFO - PROCESS | 8298 | |10;stanford-crypto-aes;85;92;93;84;84;84;86;85;85;84 17:41:41 INFO - PROCESS | 8298 | |11;stanford-crypto-ccm;122;119;117;130;119;117;119;124;116;127 17:41:41 INFO - PROCESS | 8298 | |12;stanford-crypto-pbkdf2;156;144;157;144;157;143;157;153;144;163 17:41:41 INFO - PROCESS | 8298 | |13;stanford-crypto-sha256-iterative;68;68;69;71;70;70;68;70;67;68 17:41:41 INFO - PROCESS | 8298 | __end_tp_report 17:41:41 INFO - PROCESS | 8298 | __start_cc_report 17:41:41 INFO - PROCESS | 8298 | _x_x_mozilla_cycle_collect,970 17:41:41 INFO - PROCESS | 8298 | __end_cc_report 17:41:41 INFO - PROCESS | 8298 | __startTimestamp1455241301773__endTimestamp 17:41:41 INFO - PROCESS | 8298 | 17:41:41 INFO - PROCESS | 8298 | ------- Summary: start ------- 17:41:41 INFO - PROCESS | 8298 | Number of tests: 14 17:41:41 INFO - PROCESS | 8298 | 17:41:41 INFO - PROCESS | 8298 | [#0] ai-astar Cycles:10 Average:109.10 Median:111.00 stddev:4.23 (3.8%) stddev-sans-first:4.48 17:41:41 INFO - PROCESS | 8298 | Values: 109.0 110.0 105.0 110.0 111.0 111.0 99.0 110.0 112.0 114.0 17:41:41 INFO - PROCESS | 8298 | 17:41:41 INFO - PROCESS | 8298 | [#1] audio-beat-detection Cycles:10 Average:143.80 Median:150.00 stddev:16.36 (10.9%) stddev-sans-first:16.64 17:41:41 INFO - PROCESS | 8298 | Values: 157.0 123.0 149.0 164.0 127.0 148.0 151.0 128.0 165.0 126.0 17:41:41 INFO - PROCESS | 8298 | 17:41:41 INFO - PROCESS | 8298 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.99 (0.6%) stddev-sans-first:0.97 17:41:41 INFO - PROCESS | 8298 | Values: 160.0 160.0 161.0 162.0 161.0 162.0 160.0 161.0 163.0 161.0 17:41:41 INFO - PROCESS | 8298 | 17:41:41 INFO - PROCESS | 8298 | [#3] audio-fft Cycles:10 Average:85.50 Median:75.00 stddev:15.63 (20.8%) stddev-sans-first:16.11 17:41:41 INFO - PROCESS | 8298 | Values: 75.0 74.0 93.0 100.0 74.0 72.0 75.0 117.0 99.0 76.0 17:41:41 INFO - PROCESS | 8298 | 17:41:41 INFO - PROCESS | 8298 | [#4] audio-oscillator Cycles:10 Average:108.10 Median:95.00 stddev:20.21 (21.3%) stddev-sans-first:20.88 17:41:41 INFO - PROCESS | 8298 | Values: 95.0 96.0 140.0 95.0 97.0 96.0 136.0 95.0 95.0 136.0 17:41:41 INFO - PROCESS | 8298 | 17:41:41 INFO - PROCESS | 8298 | [#5] imaging-gaussian-blur Cycles:10 Average:115.20 Median:115.00 stddev:1.03 (0.9%) stddev-sans-first:0.33 17:41:41 INFO - PROCESS | 8298 | Values: 118.0 115.0 115.0 115.0 115.0 115.0 115.0 115.0 114.0 115.0 17:41:41 INFO - PROCESS | 8298 | 17:41:41 INFO - PROCESS | 8298 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.00 stddev:1.35 (0.9%) stddev-sans-first:1.42 17:41:41 INFO - PROCESS | 8298 | Values: 145.0 145.0 146.0 145.0 146.0 144.0 145.0 149.0 145.0 145.0 17:41:41 INFO - PROCESS | 8298 | 17:41:41 INFO - PROCESS | 8298 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 17:41:41 INFO - PROCESS | 8298 | Values: 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 17:41:41 INFO - PROCESS | 8298 | 17:41:41 INFO - PROCESS | 8298 | [#8] json-parse-financial Cycles:10 Average:57.80 Median:58.00 stddev:3.26 (5.6%) stddev-sans-first:3.46 17:41:41 INFO - PROCESS | 8298 | Values: 58.0 59.0 58.0 57.0 56.0 58.0 57.0 66.0 55.0 54.0 17:41:41 INFO - PROCESS | 8298 | 17:41:41 INFO - PROCESS | 8298 | [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:67.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 17:41:41 INFO - PROCESS | 8298 | Values: 66.0 67.0 66.0 66.0 67.0 67.0 67.0 67.0 66.0 66.0 17:41:41 INFO - PROCESS | 8298 | 17:41:41 INFO - PROCESS | 8298 | [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:85.00 stddev:3.39 (4.0%) stddev-sans-first:3.57 17:41:41 INFO - PROCESS | 8298 | Values: 85.0 92.0 93.0 84.0 84.0 84.0 86.0 85.0 85.0 84.0 17:41:41 INFO - PROCESS | 8298 | 17:41:41 INFO - PROCESS | 8298 | [#11] stanford-crypto-ccm Cycles:10 Average:121.00 Median:120.50 stddev:4.67 (3.9%) stddev-sans-first:4.94 17:41:41 INFO - PROCESS | 8298 | Values: 122.0 119.0 117.0 130.0 119.0 117.0 119.0 124.0 116.0 127.0 17:41:41 INFO - PROCESS | 8298 | 17:41:41 INFO - PROCESS | 8298 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.80 Median:156.50 stddev:7.35 (4.7%) stddev-sans-first:7.63 17:41:41 INFO - PROCESS | 8298 | Values: 156.0 144.0 157.0 144.0 157.0 143.0 157.0 153.0 144.0 163.0 17:41:41 INFO - PROCESS | 8298 | 17:41:41 INFO - PROCESS | 8298 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.50 stddev:1.29 (1.9%) stddev-sans-first:1.32 17:41:41 INFO - PROCESS | 8298 | Values: 68.0 68.0 69.0 71.0 70.0 70.0 68.0 70.0 67.0 68.0 17:41:41 INFO - PROCESS | 8298 | -------- Summary: end -------- 17:41:41 INFO - PROCESS | 8298 | 17:41:42 INFO - TEST-INFO | 8298: exit 0 17:41:42 INFO - TEST-OK | kraken | took 59323ms 17:41:42 INFO - SUITE-END | took 1172s 17:41:42 INFO - Completed test suite (00:19:32) 17:41:42 INFO - Working with test: dromaeo_css 17:41:42 INFO - Generating results file: dromaeo_css 17:41:42 INFO - Working with test: kraken 17:41:42 INFO - Generating results file: kraken 17:41:42 INFO - javascript benchmark 17:41:42 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:41:42 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 17:41:42 INFO - process_Request line: dromaeo_css 6642.64 graph.html#tests=[[72,201,35]] 17:41:42 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:41:43 INFO - process_Request line: kraken 1516.40 graph.html#tests=[[232,201,35]] 17:41:43 INFO - RETURN: dromaeo_css: 6642.64 17:41:43 INFO - RETURN: kraken: 1516.40 17:41:43 INFO - javascript benchmark 17:41:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3113.5329700544917, 3120.1107684309977, 3161.5573819665237, 3166.414213370527, 3195.6325022622405, 5019.297298378221, 5083.0, 5104.795808167673, 5137.1523698589735, 5146.922796158051, 5057.418396884359, 5128.0, 5129.692218466895, 5159.1229490986525, 5182.689038657673, 4686.484486706459, 4714.740689262089, 4725.952740472603, 4749.430068391798, 4923.82766603169, 4834.0815245103495, 4835.347228124193, 4875.463698993108, 4895.779689913945, 4899.8040078396825, 4710.22281323583, 4715.952840471586, 4737.289406589005, 4799.544043315879, 4827.493113223096, 4745.857624271277, 4756.0, 4768.73771942543, 4795.328653988445, 4817.78319975602, 4736.976315118402, 4744.312074749177, 4751.572358487718, 4753.263244197155, 4756.619470442356, 5006.249062640633, 5010.949890501085, 5060.190369540893, 5104.515071068243, 5128.71792051437, 5602.803901863415, 5605.299337582802, 5615.550755939515, 5619.438056194389, 5621.690807005613, 5604.3835178130375, 5641.407652196543, 5657.4908258256955, 5660.660360378391, 5669.036263835158, 5193.844184674465, 5292.179712144623, 5296.0, 5335.1730481775385, 5387.164989426645, 5642.520385767174, 5647.943520564741, 5648.717564121777, 5650.943490565041, 5686.60193786431, 5426.538744206708, 5431.755570999315, 5432.29380180574, 5434.0, 5437.918431223535, 5561.805336813192, 5579.553635709133, 5609.80365687199, 5613.354464236583, 5654.886902261932, 5407.486288802557, 5415.079436495726, 5428.104362780097, 5431.8098866539485, 5437.32033495813, 5362.812301569505, 5455.536279416215, 5486.067368547357, 5497.862553436116, 5577.721113944286, 4335.609795118455, 4376.256036473807, 4381.101874115799, 4410.713303635253, 4417.4036505072045, 3852.460655508231, 3889.124946886928, 3903.726739128291, 3909.863154789569, 3929.135590170158, 5120.462351453119, 5184.326037615086, 5207.7916883325, 5225.0, 5262.526372626406, 5553.666779993213, 5583.832485025456, 5597.692126932976, 5602.803901863415, 5629.071203251499, 5172.301739265226, 5172.379314482211, 5177.456367081478, 5178.663386879916, 5229.320188375563, 4631.258998560282, 4654.767261636905, 4723.220668589713, 4764.880877978078, 4767.308740232646, 5624.55003599711, 5634.577406694514, 5637.746301416364, 5640.85897852557, 5641.2384328116, 5393.541548968382, 5398.3791863934575, 5401.432849550741, 5435.945640543702, 5449.04641687711, 5651.0, 5725.599208055396, 5820.650760954187, 5908.0, 5924.496417804535, 5556.888862222814, 5558.638688485235, 5559.388467268516, 5567.109262517978, 5567.526760225426, 5583.162525621189, 5614.185943038155, 5622.297212848394, 5634.380218175916, 5634.718264086698, 5397.190421436816, 5421.783128674809, 5501.312335958005, 5523.972380138073, 5525.336959564717, 5491.450854914477, 5498.80754173602, 5507.697076660822, 5507.779688812563, 5509.724513774215, 5395.649282796606, 5402.297701298806, 5402.837914862561, 5421.322334708161, 5457.481539253765, 5305.124654431976, 5378.327709036371, 5410.918836217538, 5503.174523821459, 5527.944720552743, 5305.389880163676, 5342.332208473941, 5343.305370301836, 5344.171653393731, 5378.139497680352], "unit": "score", "name": "dojo.html", "value": 5137.449659479876}, {"lowerIsBetter": false, "replicates": [520.1911028350918, 549.9147632117023, 577.2639884147712, 579.1746760865765, 594.6432140715568, 27016.594751078726, 35463.645363546355, 35757.64242357576, 35776.10559736008, 35803.4629480558, 38295.0, 38860.222795544076, 38881.41677874827, 38882.22235555287, 38886.0, 8394.832103357929, 8560.571971401436, 8618.698345557907, 8624.0, 8628.050914399411, 8629.65481380744, 8828.117188281152, 8847.20375166235, 8847.33644976626, 8848.469091854477, 8725.214730674237, 8867.024627290994, 8873.733787986339, 8879.200871921526, 8883.333749968746, 8750.431221970583, 8804.163604457566, 8808.383413161082, 8822.382433229677, 8823.55882205887, 8670.913290867074, 8825.0, 8844.11558844117, 8847.646094156225, 8848.0, 38687.41968870469, 39158.80420597879, 39164.412533812014, 39230.21539569193, 39287.41068883969, 3264.05342450689, 3357.61387440445, 3447.5862896452586, 3871.2838124946975, 4034.875200023909, 28340.716592834015, 28406.573901391497, 28819.711802881913, 28937.565936510968, 29240.561391579144, 3905.882823515299, 3940.527136743609, 4004.759714417115, 4089.7750623715683, 4099.057216840143, 263474.0, 266208.0, 266320.0, 266500.0, 267406.0, 49560.75219623879, 55020.724896376065, 55445.1683224752, 55492.0, 56577.0, 52199.217011744855, 52209.47790522046, 52490.47509524932, 52516.21225681618, 52553.211701824504, 13792.172469651852, 13888.097273677178, 13923.791143132861, 13990.370433330525, 13992.09051411655, 10290.485475726184, 11403.258788178742, 11582.6525204244, 11629.418529073513, 11630.302181868945, 17672.646547068987, 17703.93776373422, 17771.0, 17816.91091544534, 17820.732689009674, 7150.5352152109945, 7263.401638323851, 7446.755349450761, 7462.440316976248, 7518.548887066793, 969.1132613658565, 983.5573991703762, 1065.9819872022201, 1133.2520536445907, 1243.5461056714414, 26509.0, 26656.466870662865, 26741.331466713098, 26828.0, 27049.86475067612, 981.617169303972, 1083.1226706367868, 1085.8208395614636, 1119.874526101263, 1191.4459776204108, 13374.39815208318, 13639.659008524668, 15629.68740625181, 16132.354705811636, 16243.745978221355, 296781.0, 298978.0, 299412.0, 299454.0, 301125.0, 51165.74417127965, 51494.485055149715, 51533.48466515362, 51547.22679159816, 51671.22493162606, 1333.8866196373224, 1354.4988354308969, 1357.606294174698, 1373.7595920713836, 1382.3641125082574, 25844.48311033731, 26166.73833261643, 26268.73731262663, 26465.470690586466, 26486.470270594866, 39042.0, 39224.0, 39379.21241575095, 39406.99999999885, 39472.21055578815, 275618.0, 295359.0, 300894.0, 301051.0, 301072.0, 27301.726982729917, 27791.58312625353, 27954.58068128939, 27971.0, 27974.741136649307, 37365.43951840779, 38083.238335232585, 38433.0, 38648.80675596604, 38992.415113772746, 31603.683963160074, 31717.36565268728, 32584.0, 32966.34067318688, 35054.824725876206, 34263.0, 34888.47667284942, 35020.0, 35660.0, 35899.0, 36117.27765444624, 36390.63609363873, 36897.26205475822, 37358.813205933795, 37423.812880935424, 26840.463190736467, 27958.860205698842, 29143.85428072931, 29505.11484655464, 30992.380152397276, 24457.26628201157, 24765.25704228876, 24816.379590510383, 25143.35994720528, 25246.747532525176], "unit": "score", "name": "ext.html", "value": 17760.3841418405}, {"lowerIsBetter": false, "replicates": [346.9902583482068, 354.9609542950275, 358.51063298597404, 358.82238292045434, 363.8762820640982, 13815.309234538283, 14190.065967031283, 16315.510534683963, 16772.1613919304, 17375.783695141345, 15851.445199418024, 16393.508194754148, 16886.83113168868, 16931.3227470901, 16942.407015754452, 5309.0709125903, 5523.502884740373, 5523.889522209573, 5527.309086364205, 5531.529819965308, 4019.8191081401405, 5438.700871452069, 5478.808241711541, 5793.102069179284, 6030.366811484775, 5822.359540450547, 5934.495567876714, 5985.683149707057, 5994.190784244115, 5999.220101386813, 6069.484093852028, 6069.635821850703, 6073.453389194994, 6103.176071230394, 6106.419890110455, 5186.740662966874, 5231.503007214308, 5247.632665713401, 5331.040412725708, 5332.706701131437, 19192.61614767711, 19835.80164198354, 19846.404607861787, 19947.700784488243, 20050.398488045383, 2183.9017244224046, 2264.9433764155865, 2595.4290056187797, 2865.398266364066, 2904.7966642335045, 12478.0, 12612.747745045139, 12892.226466411952, 12972.156809807333, 13436.865631343659, 1835.807240239769, 1900.5628705397698, 1909.5321646196633, 1919.4913347962802, 1938.6510428122933, 56520.0, 56548.71725641345, 57232.42767572313, 57622.0, 58186.127208091486, 9260.768480788034, 9635.373700709431, 9643.99999999986, 9666.64666946628, 9714.514274286257, 12584.622461326175, 12643.11498195136, 12664.303463309423, 12720.173188742701, 12769.489220431264, 7317.0, 7321.828219028157, 7362.411007119417, 7401.185869554345, 7418.517796343221, 7112.964435177894, 7126.251743566954, 7171.533850299714, 7185.892211616725, 7190.856182876313, 5143.537081662668, 5778.739956701958, 5851.795187168429, 5881.470667639933, 5888.440598143169, 1686.5024817678814, 1730.6019615488508, 1731.1344327836082, 1750.1861634340094, 1782.08222765276, 449.77736020669323, 463.6684770389188, 483.0, 485.5484399508491, 983.2920297385871, 10968.890311096946, 11183.0, 11367.488463019185, 11376.431178441046, 11791.174617776673, 479.09451137350436, 485.20426500539145, 490.35518293444005, 493.543472288132, 494.2882249560621, 5961.857626983914, 6370.840728981812, 6388.7125079371535, 6394.616323020634, 6403.807885763435, 521989.0, 527998.0, 536224.0, 541808.0, 544941.0, 68042.3195768036, 74635.0, 77620.0, 79300.0, 80708.0, 469.1157168736887, 484.63894398673216, 506.05367961911463, 519.5220397234554, 522.3340241192434, 10159.847602285823, 10452.529636166542, 10666.306690065121, 10714.19643526723, 11029.61396351156, 33892.49161262534, 34011.31977360488, 34117.147071323416, 35150.0, 37092.62907371, 43367.78316108399, 43744.562554374046, 44472.33291500695, 44787.328190077824, 45194.54805451904, 7047.260037695968, 7101.857962840818, 7369.557826530426, 7421.554706717614, 7538.886916696364, 8109.0, 9255.76860578464, 9273.67542136022, 10922.836157457803, 11381.879594675407, 3193.9840300798346, 6666.0, 7892.85553594737, 9616.567254473426, 10340.172786177238, 9937.453440060577, 9981.301308908307, 10230.181585472996, 10307.845382319121, 10422.166226701695, 7476.70093196266, 8804.339674524308, 9546.379485333431, 9851.359661621971, 10308.381497110197, 7400.333969942731, 7412.814679633052, 7444.181140074696, 7474.850502990019, 7479.326860582573, 8554.957225213833, 9176.587053582738, 10465.319754215952, 10669.41318227505, 10839.241253112521], "unit": "score", "name": "jquery.html", "value": 7628.878834295058}, {"lowerIsBetter": false, "replicates": [1281.4361680860427, 1422.7581311177098, 1430.1776478524848, 1589.745640697488, 1772.1227992143884, 7137.2505886881845, 7670.53976761394, 7747.690092396311, 7770.4560680752365, 7814.0, 7679.155292917789, 7873.8818917716135, 7880.921190788091, 7892.447528672995, 7895.486793358442, 1902.5243689077731, 1950.1711772496703, 2140.646793279107, 2219.345293138528, 2240.2271216430386, 2200.3398980305924, 2205.1620384254043, 2205.9227927022557, 2207.0509680837235, 2207.073029327686, 2088.8955552222405, 2199.1643175593254, 2203.9779602203935, 2213.900374483144, 2217.7116974793253, 2202.90086946087, 2214.900329485169, 2232.229880691159, 2253.5605556916407, 2264.8188144948363, 2178.1505212966954, 2205.757366689663, 2206.724159480065, 2208.7791220877943, 2226.810721088709, 7992.760217193493, 8014.959925200336, 8047.39644526657, 8055.275025247697, 8070.596470176526, 4633.0733853229485, 4788.0, 4789.976050119727, 4790.377250957354, 4795.808167673289, 2966.2287805170813, 3043.269615292336, 3062.98921355952, 3085.1361618746787, 3093.6287645482685, 943.7357539888842, 961.624966263158, 963.2053555816409, 979.5934687104843, 1010.4038617215805, 11010.669679909615, 11040.447977601169, 11063.778724425467, 11065.668029959113, 11087.72280692989, 4064.6545043671026, 4163.167366526707, 4218.8523401680795, 4245.150969806051, 4251.149770046003, 9005.594748236344, 9013.819723605491, 9025.323100767337, 9026.593803278869, 9030.683926062688, 4787.952120478821, 4795.664303498722, 4797.95202047982, 4799.0, 4807.495213002654, 4448.088141930896, 4453.888652783707, 4458.197524445566, 4458.598726114666, 4461.286194208911, 3135.604655928136, 3176.3964846679055, 3476.5480487536456, 3490.7905525668543, 3522.647735226457, 1119.4906317625462, 1132.3432409202642, 1133.8639363276295, 1152.9596464123715, 1157.6469176900957, 1339.6650837290676, 1381.7650999330137, 1396.923169225682, 1404.4382247101241, 1406.367134789349, 7345.375643070292, 7498.475106742476, 7535.208803075708, 7559.697612095564, 7625.580593067323, 1134.126722423729, 1137.38581166171, 1147.6212849759559, 1152.1128730877178, 1166.1894982986744, 5874.618149820248, 5915.438033386821, 5940.257467816523, 5944.286685597669, 5956.55325850563, 9291.349605527548, 9672.95163524178, 9674.70975870725, 9800.068993445611, 9805.656802011896, 9626.229901607854, 9715.07706767856, 9716.708498745049, 9734.805303893883, 9748.512574371252, 7307.07716913239, 7517.210692877278, 7601.809954751176, 7661.0, 7672.388798352297, 7129.679164437509, 7295.124585049828, 7310.049693539806, 7310.853782924418, 7323.231060738546, 8381.664733410595, 8513.148685131437, 8734.65061397537, 8756.4308319959, 8760.78098047554, 8767.123287671182, 8905.866412003696, 8913.910860891567, 9039.728808135766, 9042.231410330196, 6915.239323674492, 6968.651567421507, 7002.404795592432, 7012.4390048796995, 7013.614251216232, 6849.4177994871, 7253.637318134178, 7415.4809163360205, 7422.554646721214, 7432.0, 6959.547629404073, 7050.823729406806, 7076.752313668997, 7088.645567721696, 7096.219415864354, 7086.574805511686, 7091.64541772899, 7097.609631470112, 7115.039469671528, 7208.531445456028, 7075.929240707733, 7101.82245443868, 7140.2859714030255, 7142.214356420894, 7152.9284707152265, 6551.770688025897, 6557.639329836905, 6592.71442068792, 6601.207855057424, 6610.206775186816, 6574.671266436755, 6641.900371494335, 6644.734210631521, 6758.898616520854, 6766.729330826909], "unit": "score", "name": "mootools.html", "value": 4521.076241511384}, {"lowerIsBetter": false, "replicates": [330.2981165024322, 333.36493978970066, 336.50197707393056, 336.63306995375035, 344.47811565478287, 5613.46672066154, 5711.114777209539, 5755.971220143899, 5815.854603634906, 5821.563382746295, 5514.5864060195445, 5610.186522954169, 5638.182463542794, 5668.376478587352, 5703.3441154267275, 4423.933640995388, 4440.467143942723, 4455.777211139446, 4465.598096171344, 4466.441694788152, 4259.659227261827, 4349.521552629209, 4457.08629730906, 4460.264056430685, 4470.664700147486, 4432.556744325574, 4443.089166720831, 4454.665900057508, 4457.1977044132045, 4463.776811159445, 4430.291153415455, 4441.666874984389, 4442.178197033543, 4443.7111587746695, 4445.933311000337, 3936.252112098692, 3936.5866584008554, 3938.9409158862354, 3942.073612701042, 3946.7039972002217, 5312.946870531284, 5484.0, 5484.095124304485, 5491.560675145979, 5515.283013208257, 5124.897502049938, 5127.846164615067, 5130.615203859688, 5136.717480538568, 5143.0, 6113.174721412597, 6113.358097399753, 6115.388461153893, 6115.4801841843055, 6123.418275263843, 4055.6349928506575, 4130.6282434581035, 4209.3896385024, 4229.661627069827, 4241.533431322583, 6244.313125556185, 6330.9683451582905, 6336.588121772116, 6347.143135676671, 6357.554971152022, 4333.934990975138, 4335.869923902288, 4337.609615134653, 4338.587834155814, 4340.82636694535, 4307.719998200169, 4386.780660966939, 4387.012922092504, 4390.8024138913825, 4392.494863090722, 5081.593472522263, 5098.158803797406, 5098.9490105098475, 5101.234814777738, 5104.744762761847, 6099.817005489843, 6114.48026917717, 6116.480099191618, 6117.571769976059, 6130.754769809158, 1517.4233791159288, 1553.8523840235387, 1554.4093244567218, 1556.3152213026458, 1558.9766153507705, 1021.9131373833308, 1027.209049032241, 1041.6093964763213, 1044.5717255925035, 1045.7856139491387, 5797.4782269595935, 5825.2135961644635, 5828.562857785683, 5831.446012628793, 5837.124431335334, 6257.0614407838275, 6265.530085243625, 6273.404026617464, 6273.498120150377, 6281.0, 5799.710014499258, 5804.129380592861, 5812.331581868055, 5812.59311848175, 5822.534197264209, 3266.281418088017, 3373.9325213495595, 3381.391349557054, 3384.1201287665385, 3385.932281354359, 6541.803745887631, 6593.274739778621, 6614.966925165343, 6623.0, 6625.271220165778, 6436.356364363526, 6455.289918109004, 6469.094326794253, 6472.029195620695, 6477.838054048687, 6434.002537796416, 6475.740970361227, 6529.2817790043055, 6541.084248205255, 6543.345665433419, 6264.590467144856, 6268.529860260407, 6271.874562508816, 6273.215848018997, 6273.749050037947, 6051.576389652682, 6072.605280656743, 6192.256929168529, 6240.720652266184, 6275.152854364603, 6576.638284894377, 6590.505712071518, 6600.372964568358, 6606.0, 6624.8343791405605, 4231.9576804231565, 4245.341971994346, 4248.383984322318, 4250.107477429774, 4253.106847562047, 6204.5967012144065, 6329.7151628175925, 6350.333215012542, 6355.269144048309, 6357.745690172342, 6163.722632481459, 6164.075388691732, 6169.876602468015, 6174.938250617616, 6183.938160618336, 6159.938400615936, 6165.075238714228, 6167.722452489559, 6169.043798211284, 6169.383061693795, 5897.997340452048, 5991.2510936132985, 6042.335343112166, 6042.607230530001, 6053.969730151321, 6129.724162412613, 6192.182556936493, 6203.844903877439, 6206.255249369924, 6210.689465526615, 6011.489023433057, 6058.545609079249, 6075.422834830684, 6075.939240607538, 6076.0278355462915], "unit": "score", "name": "prototype.html", "value": 4617.095555818401}, {"lowerIsBetter": false, "replicates": [708.1396103733962, 763.4960925788977, 774.1136398823347, 785.3246208260891, 804.8229389534303, 12840.293783841886, 13046.217226966388, 13058.2817945013, 13094.279814610192, 13107.213567185963, 12542.874571254284, 12985.870141298585, 13092.934535327335, 13106.213627182377, 13109.672258193526, 677.7085853083172, 693.6705065094066, 810.5825499867573, 825.6037102190952, 825.9421840471169, 800.1358532784578, 816.1512027491402, 819.9877001844977, 822.4777266435826, 822.5393779483478, 862.3790870573177, 868.3487384461654, 868.8349213649418, 869.7564681889081, 869.8390797702414, 699.3426179391381, 710.8187412209879, 711.9252478489788, 712.5582139073756, 861.8707193920931, 616.4205646692095, 622.107276058857, 626.4393367935672, 626.683524819963, 626.9310375858652, 12897.355132243445, 12944.741105177938, 12945.482180712761, 13015.0, 13017.349132543335, 11823.645290641294, 12006.459709313101, 12037.87962120385, 12303.384830758516, 12682.239065656091, 10227.130693891027, 10371.844422333672, 10435.686929392054, 10501.474926253657, 10630.681079567625, 3497.3189546913177, 3519.753617246794, 3536.752427330088, 3574.3566158091535, 3622.855085796565, 47829.28256076162, 48083.75958120187, 48139.27791083136, 48202.517974820155, 49615.25577116346, 9442.433453992782, 9554.235661147091, 9891.554880030415, 9952.281538920284, 10058.497075146213, 18064.458066258034, 18067.63864722698, 18068.63862722738, 18071.819281807013, 18085.276588936296, 7167.247439018828, 7232.963835180895, 7249.456290778213, 7466.477346585795, 7613.238676132453, 3862.806859657006, 3916.96083039166, 3939.881803545898, 3990.7206495545033, 4014.157027024299, 3025.3041800385595, 3044.512877939519, 3044.710752478511, 3056.862441190152, 3062.7090426409454, 554.2296208270507, 565.8472212502601, 566.153600367445, 569.2514343638103, 580.7647902599454, 402.28594245214975, 404.41360027959576, 510.4308695804226, 533.4398881174751, 550.2983695787823, 7686.501132279263, 7825.960870195612, 7949.364050875916, 7959.742912660034, 8205.179482051746, 545.4082320682104, 586.1939832729996, 591.5622439394817, 593.3502814418205, 597.9820605381846, 3572.7677700949357, 3782.205736795249, 3796.52543432071, 3850.5571859236547, 3919.3729003359326, 52444.21333679998, 53117.468825311254, 53323.0, 53458.732706336996, 54025.459745402826, 47369.52630473651, 47515.28727069097, 48105.75947120242, 48591.27113093236, 48606.681131452686, 43203.56796432058, 43523.12953740908, 43733.78133109378, 43946.560534394244, 44161.77919110384, 7410.740624078131, 7440.255974402517, 7667.923320766721, 7708.576028318496, 7900.209979002054, 28279.858600706866, 32179.35641287208, 32947.176320592174, 32974.34051318912, 33094.17264568405, 38778.0, 41918.790406047774, 42077.15845683008, 42218.36672449854, 42329.0, 9622.855657165288, 9743.610255589698, 9745.463999480096, 9964.903860575187, 9969.252306077218, 10123.139533139765, 10261.281710280507, 10307.184564610236, 10368.688939331832, 10663.880292569169, 9775.853362199716, 9987.350822196535, 10044.698659040241, 10345.224108191765, 10359.741006474898, 8997.64009439615, 9293.0, 9436.150746432853, 9442.197413219954, 9457.054294570764, 10475.738106547396, 10485.580576776843, 10844.40355780408, 10889.618863339745, 11023.44882755843, 8714.738557843275, 8734.882888970616, 8821.823563528566, 8846.646134154562, 9051.683191088281, 7992.560409177551, 8552.444091134057, 8762.430442021248, 8779.341549383695, 8878.245349145394], "unit": "score", "name": "yui.html", "value": 5912.031322879965}], "name": "dromaeo_css", "value": 6642.642503672403}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 105.0, 110.0, 111.0, 111.0, 99.0, 110.0, 112.0, 114.0], "unit": "score", "name": "ai-astar", "value": 109.1}, {"lowerIsBetter": true, "replicates": [157.0, 123.0, 149.0, 164.0, 127.0, 148.0, 151.0, 128.0, 165.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 143.8}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 161.0, 162.0, 161.0, 162.0, 160.0, 161.0, 163.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.1}, {"lowerIsBetter": true, "replicates": [75.0, 74.0, 93.0, 100.0, 74.0, 72.0, 75.0, 117.0, 99.0, 76.0], "unit": "score", "name": "audio-fft", "value": 85.5}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 140.0, 95.0, 97.0, 96.0, 136.0, 95.0, 95.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 108.1}, {"lowerIsBetter": true, "replicates": [118.0, 115.0, 115.0, 115.0, 115.0, 115.0, 115.0, 115.0, 114.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.2}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 146.0, 145.0, 146.0, 144.0, 145.0, 149.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [58.0, 59.0, 58.0, 57.0, 56.0, 58.0, 57.0, 66.0, 55.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 57.8}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 66.0, 66.0, 67.0, 67.0, 67.0, 67.0, 66.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.5}, {"lowerIsBetter": true, "replicates": [85.0, 92.0, 93.0, 84.0, 84.0, 84.0, 86.0, 85.0, 85.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.2}, {"lowerIsBetter": true, "replicates": [122.0, 119.0, 117.0, 130.0, 119.0, 117.0, 119.0, 124.0, 116.0, 127.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.0}, {"lowerIsBetter": true, "replicates": [156.0, 144.0, 157.0, 144.0, 157.0, 143.0, 157.0, 153.0, 144.0, 163.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.8}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 69.0, 71.0, 70.0, 70.0, 68.0, 70.0, 67.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.9}], "name": "kraken", "value": 1516.4}]} 17:41:43 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1516.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6642.64"}}} 17:41:43 INFO - Return code: 0 17:41:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 17:41:43 INFO - # TBPL SUCCESS # 17:41:43 INFO - Running post-action listener: _resource_record_post_action 17:41:43 INFO - Running post-run listener: _resource_record_post_run 17:41:44 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 16384; Write bytes: 299368448; Read time: 28; Write time: 343064 17:41:44 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 1290240; Read time: 0; Write time: 44 17:41:44 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 16384; Write bytes: 298078208; Read time: 28; Write time: 343020 17:41:44 INFO - Running post-run listener: _upload_blobber_files 17:41:44 INFO - Blob upload gear active. 17:41:44 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 17:41:44 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 17:41:44 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', 'B2G-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 17:41:44 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 B2G-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 17:41:44 INFO - (blobuploader) - INFO - Open directory for files ... 17:41:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:41:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:41:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:41:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:41:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:41:45 INFO - (blobuploader) - INFO - Done attempting. 17:41:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 17:41:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:41:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:41:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:41:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:41:46 INFO - (blobuploader) - INFO - Done attempting. 17:41:46 INFO - (blobuploader) - INFO - Iteration through files over. 17:41:46 INFO - Return code: 0 17:41:46 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 17:41:46 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 17:41:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/188a203ffd3b5bd21d8eb93c40ac1d931a1a1e3f57c2cdcc54609ef63f39c94cedeb49db580f2dd6b3540425ba4729483ecd08c1df41624f31e751ed60972f3b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/98efb8e916cf3e626962f22d7f41ffa43b866e18dc57f2091612b939a81671af68344d5e2cceb446863216f2503524aa145b852e3db084be47e2827ec9e37d1e"} 17:41:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 17:41:46 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 17:41:46 INFO - Contents: 17:41:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/188a203ffd3b5bd21d8eb93c40ac1d931a1a1e3f57c2cdcc54609ef63f39c94cedeb49db580f2dd6b3540425ba4729483ecd08c1df41624f31e751ed60972f3b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/98efb8e916cf3e626962f22d7f41ffa43b866e18dc57f2091612b939a81671af68344d5e2cceb446863216f2503524aa145b852e3db084be47e2827ec9e37d1e"} 17:41:46 INFO - Running post-run listener: copy_logs_to_upload_dir 17:41:46 INFO - Copying logs to upload dir... 17:41:46 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 17:41:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.329989 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-02-11 17:41:46.923627) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-11 17:41:46.927229) ========= 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=62c568580acbfdaac3eec7be000001dc-1455240070.764407-1476042235 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/188a203ffd3b5bd21d8eb93c40ac1d931a1a1e3f57c2cdcc54609ef63f39c94cedeb49db580f2dd6b3540425ba4729483ecd08c1df41624f31e751ed60972f3b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/98efb8e916cf3e626962f22d7f41ffa43b866e18dc57f2091612b939a81671af68344d5e2cceb446863216f2503524aa145b852e3db084be47e2827ec9e37d1e"} build_url:https://queue.taskcluster.net/v1/task/dtI9QKRQQ2mp1iScemiuEw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011254 build_url: 'https://queue.taskcluster.net/v1/task/dtI9QKRQQ2mp1iScemiuEw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/188a203ffd3b5bd21d8eb93c40ac1d931a1a1e3f57c2cdcc54609ef63f39c94cedeb49db580f2dd6b3540425ba4729483ecd08c1df41624f31e751ed60972f3b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/98efb8e916cf3e626962f22d7f41ffa43b866e18dc57f2091612b939a81671af68344d5e2cceb446863216f2503524aa145b852e3db084be47e2827ec9e37d1e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-11 17:41:46.951614) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 17:41:46.951949) ========= 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=62c568580acbfdaac3eec7be000001dc-1455240070.764407-1476042235 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004526 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 17:41:47.034751) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-11 17:41:47.035086) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-11 17:41:47.035365) ========= ========= Total master_lag: 0.23 =========