builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-066 starttime: 1456942280.2 results: success (0) buildid: 20160302073251 builduid: e410d4ddbc8e4cee9174754939ffb5ba revision: bdde3fedb45be528f985a0aff373b37b010fb927 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-02 10:11:20.200560) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-02 10:11:20.200990) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-02 10:11:20.201277) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1456941755.609493-1377747993 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006349 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-02 10:11:20.224207) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-02 10:11:20.224506) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-02 10:11:20.244667) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 10:11:20.245053) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1456941755.609493-1377747993 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004632 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 10:11:20.294525) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-02 10:11:20.294839) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-02 10:11:20.295198) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 10:11:20.295496) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1456941755.609493-1377747993 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-02 10:11:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-03-02 10:11:20 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.153027 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 10:11:20.463551) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 10:11:20.466908) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1456941755.609493-1377747993 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017810 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 10:11:20.516400) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 10:11:20.519788) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bdde3fedb45be528f985a0aff373b37b010fb927 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev bdde3fedb45be528f985a0aff373b37b010fb927 --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=82c74bd3bc9a11c5833d2010000001e6-1456941755.609493-1377747993 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-02 10:11:21,093 truncating revision to first 12 chars 2016-03-02 10:11:21,093 Setting DEBUG logging. 2016-03-02 10:11:21,093 attempt 1/10 2016-03-02 10:11:21,093 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bdde3fedb45b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-02 10:11:21,358 unpacking tar archive at: mozilla-central-bdde3fedb45b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.567146 ========= master_lag: 0.28 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 10:11:21.371680) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-02 10:11:21.372051) ========= echo bdde3fedb45be528f985a0aff373b37b010fb927 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'bdde3fedb45be528f985a0aff373b37b010fb927'] 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=82c74bd3bc9a11c5833d2010000001e6-1456941755.609493-1377747993 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False bdde3fedb45be528f985a0aff373b37b010fb927 program finished with exit code 0 elapsedTime=0.004611 script_repo_revision: 'bdde3fedb45be528f985a0aff373b37b010fb927' ========= master_lag: 0.02 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-02 10:11:21.398029) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-02 10:11:21.398310) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-02 10:11:21.410887) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-03-02 10:11:21.411206) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82c74bd3bc9a11c5833d2010000001e6-1456941755.609493-1377747993 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:11:22 INFO - MultiFileLogger online at 20160302 10:11:22 in /builds/slave/test-pgo 10:11:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:11:22 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 10:11:22 INFO - {'append_to_log': False, 10:11:22 INFO - 'base_work_dir': '/builds/slave/test-pgo', 10:11:22 INFO - 'blob_upload_branch': 'Firefox', 10:11:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 10:11:22 INFO - 'branch': 'Firefox', 10:11:22 INFO - 'buildbot_json_path': 'buildprops.json', 10:11:22 INFO - 'config_files': ('talos/linux_config.py',), 10:11:22 INFO - 'default_actions': ('clobber', 10:11:22 INFO - 'read-buildbot-config', 10:11:22 INFO - 'download-and-extract', 10:11:22 INFO - 'populate-webroot', 10:11:22 INFO - 'create-virtualenv', 10:11:22 INFO - 'install', 10:11:22 INFO - 'run-tests'), 10:11:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:11:22 INFO - 'download_minidump_stackwalk': True, 10:11:22 INFO - 'download_symbols': 'ondemand', 10:11:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:11:22 INFO - 'tooltool.py': '/tools/tooltool.py', 10:11:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:11:22 INFO - '/tools/misc-python/virtualenv.py')}, 10:11:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:11:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:11:22 INFO - 'installer_path': 'installer.exe', 10:11:22 INFO - 'log_level': 'info', 10:11:22 INFO - 'log_name': 'talos', 10:11:22 INFO - 'log_to_console': True, 10:11:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:11:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:11:22 INFO - 'opt_config_files': (), 10:11:22 INFO - 'pip_index': False, 10:11:22 INFO - 'sps_profile': False, 10:11:22 INFO - 'sps_profile_interval': 0, 10:11:22 INFO - 'suite': 'dromaeojs-e10s', 10:11:22 INFO - 'system_bits': '32', 10:11:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:11:22 INFO - 'title': 'talos-linux64-ix-066', 10:11:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:11:22 INFO - 'use_talos_json': True, 10:11:22 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 10:11:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:11:22 INFO - 'work_dir': 'build'} 10:11:22 INFO - ##### 10:11:22 INFO - ##### Running clobber step. 10:11:22 INFO - ##### 10:11:22 INFO - Running pre-action listener: _resource_record_pre_action 10:11:22 INFO - Running main action method: clobber 10:11:22 INFO - rmtree: /builds/slave/test-pgo/build 10:11:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 10:11:22 INFO - Running post-action listener: _resource_record_post_action 10:11:22 INFO - ##### 10:11:22 INFO - ##### Running read-buildbot-config step. 10:11:22 INFO - ##### 10:11:22 INFO - Running pre-action listener: _resource_record_pre_action 10:11:22 INFO - Running main action method: read_buildbot_config 10:11:22 INFO - Using buildbot properties: 10:11:22 INFO - { 10:11:22 INFO - "project": "", 10:11:22 INFO - "product": "firefox", 10:11:22 INFO - "script_repo_revision": "production", 10:11:22 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 10:11:22 INFO - "repository": "", 10:11:22 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 10:11:22 INFO - "buildid": "20160302073251", 10:11:22 INFO - "pgo_build": "True", 10:11:22 INFO - "basedir": "/builds/slave/test-pgo", 10:11:22 INFO - "buildnumber": 655, 10:11:22 INFO - "slavename": "talos-linux64-ix-066", 10:11:22 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:11:22 INFO - "platform": "ubuntu64_hw", 10:11:22 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 10:11:22 INFO - "branch": "mozilla-central", 10:11:22 INFO - "repo_path": "mozilla-central", 10:11:22 INFO - "revision": "bdde3fedb45be528f985a0aff373b37b010fb927", 10:11:22 INFO - "stage_platform": "linux64-pgo", 10:11:22 INFO - "builduid": "e410d4ddbc8e4cee9174754939ffb5ba", 10:11:22 INFO - "slavebuilddir": "test" 10:11:22 INFO - } 10:11:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/JORtoHwzRSamQmNe0h7r-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 10:11:22 INFO - Running post-action listener: _resource_record_post_action 10:11:22 INFO - ##### 10:11:22 INFO - ##### Running download-and-extract step. 10:11:22 INFO - ##### 10:11:22 INFO - Running pre-action listener: _resource_record_pre_action 10:11:22 INFO - Running main action method: download_and_extract 10:11:22 INFO - mkdir: /builds/slave/test-pgo/build/tests 10:11: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')]} 10:11:22 INFO - https://queue.taskcluster.net/v1/task/JORtoHwzRSamQmNe0h7r-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:11:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JORtoHwzRSamQmNe0h7r-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 10:11:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JORtoHwzRSamQmNe0h7r-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 10:11:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JORtoHwzRSamQmNe0h7r-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 10:11:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JORtoHwzRSamQmNe0h7r-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:11:23 INFO - Downloaded 1448 bytes. 10:11:23 INFO - Reading from file /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 10:11:23 INFO - Using the following test package requirements: 10:11:23 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 10:11:23 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 10:11:23 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:11:23 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 10:11:23 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:11:23 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 10:11:23 INFO - u'jsshell-linux-x86_64.zip'], 10:11:23 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 10:11:23 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:11:23 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 10:11:23 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 10:11:23 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:11:23 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 10:11:23 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:11:23 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 10:11:23 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:11:23 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 10:11:23 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 10:11:23 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:11:23 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:11:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:23 INFO - https://queue.taskcluster.net/v1/task/JORtoHwzRSamQmNe0h7r-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:11:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JORtoHwzRSamQmNe0h7r-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 10:11:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JORtoHwzRSamQmNe0h7r-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 10:11:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JORtoHwzRSamQmNe0h7r-g/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 10:11:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JORtoHwzRSamQmNe0h7r-g/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 10:11:24 INFO - Downloaded 23394552 bytes. 10:11:24 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'] 10:11:24 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 10:11:26 INFO - Return code: 0 10:11:26 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 10:11:26 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')]} 10:11:26 INFO - https://queue.taskcluster.net/v1/task/JORtoHwzRSamQmNe0h7r-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:11:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JORtoHwzRSamQmNe0h7r-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 10:11:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JORtoHwzRSamQmNe0h7r-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 10:11:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JORtoHwzRSamQmNe0h7r-g/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 10:11:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JORtoHwzRSamQmNe0h7r-g/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 10:11:28 INFO - Downloaded 23394552 bytes. 10:11:28 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'] 10:11:28 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 10:11:30 INFO - Return code: 0 10:11:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:30 INFO - https://queue.taskcluster.net/v1/task/JORtoHwzRSamQmNe0h7r-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:11:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JORtoHwzRSamQmNe0h7r-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 10:11:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JORtoHwzRSamQmNe0h7r-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 10:11:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JORtoHwzRSamQmNe0h7r-g/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 10:11:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JORtoHwzRSamQmNe0h7r-g/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 10:11:30 INFO - Downloaded 10808263 bytes. 10:11:30 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'] 10:11:30 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 10:11:31 INFO - Return code: 0 10:11:31 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')]} 10:11:31 INFO - https://queue.taskcluster.net/v1/task/JORtoHwzRSamQmNe0h7r-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:11:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JORtoHwzRSamQmNe0h7r-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 10:11:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JORtoHwzRSamQmNe0h7r-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 10:11:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JORtoHwzRSamQmNe0h7r-g/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 10:11:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JORtoHwzRSamQmNe0h7r-g/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 10:11:32 INFO - Downloaded 56159587 bytes. 10:11:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JORtoHwzRSamQmNe0h7r-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 10:11:32 INFO - mkdir: /builds/slave/test-pgo/properties 10:11:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 10:11:32 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 10:11:32 INFO - Contents: 10:11:32 INFO - build_url:https://queue.taskcluster.net/v1/task/JORtoHwzRSamQmNe0h7r-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 10:11:33 INFO - Running post-action listener: _resource_record_post_action 10:11:33 INFO - Running post-action listener: set_extra_try_arguments 10:11:33 INFO - ##### 10:11:33 INFO - ##### Running populate-webroot step. 10:11:33 INFO - ##### 10:11:33 INFO - Running pre-action listener: _resource_record_pre_action 10:11:33 INFO - Running main action method: populate_webroot 10:11:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:11:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:11:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:11:33 INFO - '--tppagecycles', 10:11:33 INFO - '7'], 10:11:33 INFO - 'tests': ['tsvgm']}}, 10:11:33 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:11:33 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:11:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:11:33 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 10:11:33 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:11:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:11:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:11:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:11:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:11:33 INFO - 'talos_options': ['--e10s'], 10:11:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:11:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:11:33 INFO - 'tests': ['damp', 'tps']}, 10:11:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:11:33 INFO - 'talos_options': ['--e10s'], 10:11:33 INFO - 'tests': ['damp', 'tps']}, 10:11:33 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:11:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:11:33 INFO - 'other': {'tests': ['a11yr', 10:11:33 INFO - 'ts_paint', 10:11:33 INFO - 'tpaint', 10:11:33 INFO - 'sessionrestore', 10:11:33 INFO - 'sessionrestore_no_auto_restore']}, 10:11:33 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:11:33 INFO - 'tests': ['a11yr', 10:11:33 INFO - 'ts_paint', 10:11:33 INFO - 'tpaint', 10:11:33 INFO - 'sessionrestore', 10:11:33 INFO - 'sessionrestore_no_auto_restore']}, 10:11:33 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:11:33 INFO - 'tests': ['a11yr', 10:11:33 INFO - 'ts_paint', 10:11:33 INFO - 'tpaint', 10:11:33 INFO - 'sessionrestore', 10:11:33 INFO - 'sessionrestore_no_auto_restore']}, 10:11:33 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:11:33 INFO - 'tests': ['a11yr', 10:11:33 INFO - 'ts_paint', 10:11:33 INFO - 'tpaint', 10:11:33 INFO - 'sessionrestore', 10:11:33 INFO - 'sessionrestore_no_auto_restore']}, 10:11:33 INFO - 'other_l64': {'tests': ['a11yr', 10:11:33 INFO - 'ts_paint', 10:11:33 INFO - 'tpaint', 10:11:33 INFO - 'sessionrestore', 10:11:33 INFO - 'sessionrestore_no_auto_restore']}, 10:11:33 INFO - 'other_nol64': {'tests': ['a11yr', 10:11:33 INFO - 'ts_paint', 10:11:33 INFO - 'tpaint', 10:11:33 INFO - 'sessionrestore', 10:11:33 INFO - 'sessionrestore_no_auto_restore']}, 10:11:33 INFO - 'svgr': {'tests': ['tsvgx', 10:11:33 INFO - 'tsvgr_opacity', 10:11:33 INFO - 'tart', 10:11:33 INFO - 'tscrollx', 10:11:33 INFO - 'cart']}, 10:11:33 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:11:33 INFO - 'tests': ['tsvgx', 10:11:33 INFO - 'tsvgr_opacity', 10:11:33 INFO - 'tart', 10:11:33 INFO - 'tscrollx', 10:11:33 INFO - 'cart']}, 10:11:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:11:33 INFO - 'tests': ['tp5o']}, 10:11:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:11:33 INFO - 'talos_options': ['--e10s'], 10:11:33 INFO - 'tests': ['tp5o']}, 10:11:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:11:33 INFO - 'talos_options': ['--xperf_path', 10:11:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:11:33 INFO - 'tests': ['tp5n']}, 10:11:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:11:33 INFO - 'talos_options': ['--e10s', 10:11:33 INFO - '--xperf_path', 10:11:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:11:33 INFO - 'tests': ['tp5n']}}, 10:11:33 INFO - 'talos.zip': {'path': '', 10:11:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:11:33 INFO - Running post-action listener: _resource_record_post_action 10:11:33 INFO - ##### 10:11:33 INFO - ##### Running create-virtualenv step. 10:11:33 INFO - ##### 10:11:33 INFO - Running pre-action listener: _resource_record_pre_action 10:11:33 INFO - Running main action method: create_virtualenv 10:11:33 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 10:11:33 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 10:11:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 10:11:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:11:33 INFO - Using real prefix '/usr' 10:11:33 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 10:11:33 INFO - Installing distribute.............................................................................................................................................................................................done. 10:11:35 INFO - Installing pip.................done. 10:11:35 INFO - Return code: 0 10:11:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 10:11: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')]} 10:11:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11: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')]} 10:11:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:35 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2d3b749f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2812670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a18c0>, '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 0x28a27c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a2c50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1456941755.609493-1377747993', '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 10:11:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 10:11:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:11:35 INFO - Using env: {'DISPLAY': ':0', 10:11:35 INFO - 'HOME': '/home/cltbld', 10:11:35 INFO - 'LANG': 'en_US.UTF-8', 10:11:35 INFO - 'LANGUAGE': 'en_US:en', 10:11:35 INFO - 'LOGNAME': 'cltbld', 10:11:35 INFO - 'MAIL': '/var/mail/cltbld', 10:11:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:35 INFO - 'MOZ_NO_REMOTE': '1', 10:11:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:35 INFO - 'NO_EM_RESTART': '1', 10:11:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:11:35 INFO - 'PWD': '/builds/slave/test-pgo', 10:11:35 INFO - 'SHELL': '/bin/bash', 10:11:35 INFO - 'SHLVL': '1', 10:11:35 INFO - 'TERM': 'linux', 10:11:35 INFO - 'TMOUT': '86400', 10:11:35 INFO - 'USER': 'cltbld', 10:11:35 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1456941755.609493-1377747993', 10:11:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:35 INFO - '_': '/tools/buildbot/bin/python'} 10:11:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:36 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:11:36 INFO - Cleaning up... 10:11:36 INFO - Return code: 0 10:11:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 10:11:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:36 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2d3b749f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2812670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a18c0>, '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 0x28a27c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a2c50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1456941755.609493-1377747993', '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 10:11:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 10:11:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:11:36 INFO - Using env: {'DISPLAY': ':0', 10:11:36 INFO - 'HOME': '/home/cltbld', 10:11:36 INFO - 'LANG': 'en_US.UTF-8', 10:11:36 INFO - 'LANGUAGE': 'en_US:en', 10:11:36 INFO - 'LOGNAME': 'cltbld', 10:11:36 INFO - 'MAIL': '/var/mail/cltbld', 10:11:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:36 INFO - 'MOZ_NO_REMOTE': '1', 10:11:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:36 INFO - 'NO_EM_RESTART': '1', 10:11:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:11:36 INFO - 'PWD': '/builds/slave/test-pgo', 10:11:36 INFO - 'SHELL': '/bin/bash', 10:11:36 INFO - 'SHLVL': '1', 10:11:36 INFO - 'TERM': 'linux', 10:11:36 INFO - 'TMOUT': '86400', 10:11:36 INFO - 'USER': 'cltbld', 10:11:36 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1456941755.609493-1377747993', 10:11:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:36 INFO - '_': '/tools/buildbot/bin/python'} 10:11:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:36 INFO - Downloading/unpacking psutil>=0.7.1 10:11: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 10:11: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 10:11: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 10:11: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 10:11: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 10:11: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 10:11:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 10:11:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:11:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:11:38 INFO - Installing collected packages: psutil 10:11:38 INFO - Running setup.py install for psutil 10:11:38 INFO - building 'psutil._psutil_linux' extension 10:11:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:11:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:11:38 INFO - building 'psutil._psutil_posix' extension 10:11:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:11:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:11:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:11:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:11:38 INFO - Successfully installed psutil 10:11:38 INFO - Cleaning up... 10:11:38 INFO - Return code: 0 10:11:38 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 10:11:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:38 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2d3b749f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2812670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a18c0>, '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 0x28a27c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a2c50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1456941755.609493-1377747993', '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 10:11:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 10:11:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:11:38 INFO - Using env: {'DISPLAY': ':0', 10:11:38 INFO - 'HOME': '/home/cltbld', 10:11:38 INFO - 'LANG': 'en_US.UTF-8', 10:11:38 INFO - 'LANGUAGE': 'en_US:en', 10:11:38 INFO - 'LOGNAME': 'cltbld', 10:11:38 INFO - 'MAIL': '/var/mail/cltbld', 10:11:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:38 INFO - 'MOZ_NO_REMOTE': '1', 10:11:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:38 INFO - 'NO_EM_RESTART': '1', 10:11:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:11:38 INFO - 'PWD': '/builds/slave/test-pgo', 10:11:38 INFO - 'SHELL': '/bin/bash', 10:11:38 INFO - 'SHLVL': '1', 10:11:38 INFO - 'TERM': 'linux', 10:11:38 INFO - 'TMOUT': '86400', 10:11:38 INFO - 'USER': 'cltbld', 10:11:38 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1456941755.609493-1377747993', 10:11:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:38 INFO - '_': '/tools/buildbot/bin/python'} 10:11:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:38 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:11: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 10:11: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 10:11: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 10:11: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 10:11: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 10:11: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 10:11:40 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:11:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:11:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:11:40 INFO - Installing collected packages: mozsystemmonitor 10:11:40 INFO - Running setup.py install for mozsystemmonitor 10:11:40 INFO - Successfully installed mozsystemmonitor 10:11:40 INFO - Cleaning up... 10:11:40 INFO - Return code: 0 10:11:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 10:11: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')]} 10:11:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11: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')]} 10:11:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:40 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 0x7f2d3b749f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2812670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a18c0>, '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 0x28a27c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a2c50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1456941755.609493-1377747993', '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 10:11:40 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 10:11:40 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 10:11:41 INFO - Using env: {'DISPLAY': ':0', 10:11:41 INFO - 'HOME': '/home/cltbld', 10:11:41 INFO - 'LANG': 'en_US.UTF-8', 10:11:41 INFO - 'LANGUAGE': 'en_US:en', 10:11:41 INFO - 'LOGNAME': 'cltbld', 10:11:41 INFO - 'MAIL': '/var/mail/cltbld', 10:11:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:41 INFO - 'MOZ_NO_REMOTE': '1', 10:11:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:41 INFO - 'NO_EM_RESTART': '1', 10:11:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:11:41 INFO - 'PWD': '/builds/slave/test-pgo', 10:11:41 INFO - 'SHELL': '/bin/bash', 10:11:41 INFO - 'SHLVL': '1', 10:11:41 INFO - 'TERM': 'linux', 10:11:41 INFO - 'TMOUT': '86400', 10:11:41 INFO - 'USER': 'cltbld', 10:11:41 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1456941755.609493-1377747993', 10:11:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:41 INFO - '_': '/tools/buildbot/bin/python'} 10:11:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:41 INFO - Downloading/unpacking blobuploader==1.2.4 10:11:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:43 INFO - Downloading blobuploader-1.2.4.tar.gz 10:11:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:11:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:11:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 10:11:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:11:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:43 INFO - Downloading docopt-0.6.1.tar.gz 10:11:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 10:11:43 INFO - Installing collected packages: blobuploader, requests, docopt 10:11:43 INFO - Running setup.py install for blobuploader 10:11:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:11:43 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 10:11:43 INFO - Running setup.py install for requests 10:11:44 INFO - Running setup.py install for docopt 10:11:44 INFO - Successfully installed blobuploader requests docopt 10:11:44 INFO - Cleaning up... 10:11:44 INFO - Return code: 0 10:11:44 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:11:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2d3b749f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2812670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a18c0>, '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 0x28a27c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a2c50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1456941755.609493-1377747993', '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 10:11:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 10:11:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:11:44 INFO - Using env: {'DISPLAY': ':0', 10:11:44 INFO - 'HOME': '/home/cltbld', 10:11:44 INFO - 'LANG': 'en_US.UTF-8', 10:11:44 INFO - 'LANGUAGE': 'en_US:en', 10:11:44 INFO - 'LOGNAME': 'cltbld', 10:11:44 INFO - 'MAIL': '/var/mail/cltbld', 10:11:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:44 INFO - 'MOZ_NO_REMOTE': '1', 10:11:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:44 INFO - 'NO_EM_RESTART': '1', 10:11:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:11:44 INFO - 'PWD': '/builds/slave/test-pgo', 10:11:44 INFO - 'SHELL': '/bin/bash', 10:11:44 INFO - 'SHLVL': '1', 10:11:44 INFO - 'TERM': 'linux', 10:11:44 INFO - 'TMOUT': '86400', 10:11:44 INFO - 'USER': 'cltbld', 10:11:44 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1456941755.609493-1377747993', 10:11:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:44 INFO - '_': '/tools/buildbot/bin/python'} 10:11:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:11:44 INFO - Running setup.py (path:/tmp/pip-OBmKY6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:11:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:11:44 INFO - Running setup.py (path:/tmp/pip-4FsZiD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:11:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:11:44 INFO - Running setup.py (path:/tmp/pip-Zq3_aD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:11:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:11:44 INFO - Running setup.py (path:/tmp/pip-YsTTaz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:11:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:11:44 INFO - Running setup.py (path:/tmp/pip-jNQ2lO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:11:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:11:44 INFO - Running setup.py (path:/tmp/pip-6ONVll-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:11:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:11:45 INFO - Running setup.py (path:/tmp/pip-VllAiA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:11:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:11:45 INFO - Running setup.py (path:/tmp/pip-TgKesg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:11:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:11:45 INFO - Running setup.py (path:/tmp/pip-aMJOCh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:11:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:11:45 INFO - Running setup.py (path:/tmp/pip-5OB5Bu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:11:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:11:45 INFO - Running setup.py (path:/tmp/pip-cqxZlv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:11:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:11:45 INFO - Running setup.py (path:/tmp/pip-DBjAbj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:11:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:11:45 INFO - Running setup.py (path:/tmp/pip-X_ofuo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:11:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:11:45 INFO - Running setup.py (path:/tmp/pip-2vELDl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:11:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:11:45 INFO - Running setup.py (path:/tmp/pip-v4tKaZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:11:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:11:45 INFO - Running setup.py (path:/tmp/pip-zYZMzo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:11:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:11:45 INFO - Running setup.py (path:/tmp/pip-i0Cza9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:11:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:11:45 INFO - Running setup.py install for manifestparser 10:11:45 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 10:11:45 INFO - Running setup.py install for mozcrash 10:11:45 INFO - Running setup.py install for mozdebug 10:11:46 INFO - Running setup.py install for mozdevice 10:11:46 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 10:11:46 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 10:11:46 INFO - Running setup.py install for mozfile 10:11:46 INFO - Running setup.py install for mozhttpd 10:11:46 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 10:11:46 INFO - Running setup.py install for mozinfo 10:11:46 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 10:11:46 INFO - Running setup.py install for mozInstall 10:11:46 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 10:11:46 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 10:11:46 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 10:11:46 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 10:11:46 INFO - Running setup.py install for mozleak 10:11:46 INFO - Running setup.py install for mozlog 10:11:46 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 10:11:46 INFO - Running setup.py install for moznetwork 10:11:46 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 10:11:46 INFO - Running setup.py install for mozprocess 10:11:47 INFO - Running setup.py install for mozprofile 10:11:47 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 10:11:47 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 10:11:47 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 10:11:47 INFO - Running setup.py install for mozrunner 10:11:47 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 10:11:47 INFO - Running setup.py install for mozscreenshot 10:11:47 INFO - Running setup.py install for moztest 10:11:47 INFO - Running setup.py install for mozversion 10:11:47 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 10:11:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:11:47 INFO - Cleaning up... 10:11:47 INFO - Return code: 0 10:11:47 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:11: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')]} 10:11:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11: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')]} 10:11:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:47 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2d3b749f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2812670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a18c0>, '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 0x28a27c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a2c50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1456941755.609493-1377747993', '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 10:11:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 10:11:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:11:47 INFO - Using env: {'DISPLAY': ':0', 10:11:47 INFO - 'HOME': '/home/cltbld', 10:11:47 INFO - 'LANG': 'en_US.UTF-8', 10:11:47 INFO - 'LANGUAGE': 'en_US:en', 10:11:47 INFO - 'LOGNAME': 'cltbld', 10:11:47 INFO - 'MAIL': '/var/mail/cltbld', 10:11:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:47 INFO - 'MOZ_NO_REMOTE': '1', 10:11:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:47 INFO - 'NO_EM_RESTART': '1', 10:11:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:11:47 INFO - 'PWD': '/builds/slave/test-pgo', 10:11:47 INFO - 'SHELL': '/bin/bash', 10:11:47 INFO - 'SHLVL': '1', 10:11:47 INFO - 'TERM': 'linux', 10:11:47 INFO - 'TMOUT': '86400', 10:11:47 INFO - 'USER': 'cltbld', 10:11:47 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1456941755.609493-1377747993', 10:11:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:47 INFO - '_': '/tools/buildbot/bin/python'} 10:11:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:11:47 INFO - Running setup.py (path:/tmp/pip-_dNOGD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:11:47 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 10:11:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:11:47 INFO - Running setup.py (path:/tmp/pip-hdJOWL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:11:47 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)) 10:11:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:11:47 INFO - Running setup.py (path:/tmp/pip-kPLgo5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:11:47 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)) 10:11:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:11:48 INFO - Running setup.py (path:/tmp/pip-j5w6Ye-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:11:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:11:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:11:48 INFO - Running setup.py (path:/tmp/pip-J6jdk5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:11:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 10:11:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:11:48 INFO - Running setup.py (path:/tmp/pip-UaH2EF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:11:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 10:11:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:11:48 INFO - Running setup.py (path:/tmp/pip-ziSMVO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:11:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 10:11:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:11:48 INFO - Running setup.py (path:/tmp/pip-TSIemI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:11:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 10:11:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:11:48 INFO - Running setup.py (path:/tmp/pip-1vV5DV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:11:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 10:11:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:11:48 INFO - Running setup.py (path:/tmp/pip-evgkvY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:11:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:11:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:11:48 INFO - Running setup.py (path:/tmp/pip-CJnbt_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:11:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 10:11:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:11:48 INFO - Running setup.py (path:/tmp/pip-1pWKYc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:11:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 10:11:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:11:48 INFO - Running setup.py (path:/tmp/pip-T8TECT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:11:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 10:11:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:11:48 INFO - Running setup.py (path:/tmp/pip-cX4Aix-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:11:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 10:11:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:11:48 INFO - Running setup.py (path:/tmp/pip-nEGBqL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:11:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 10:11:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:11:48 INFO - Running setup.py (path:/tmp/pip-Dg2qy2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:11:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 10:11:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:11:48 INFO - Running setup.py (path:/tmp/pip-ysejtm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:11:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 10:11:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 10:11:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 10:11:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 10:11:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:11:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:11:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:11: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 10:11: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 10:11: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 10:11: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 10:11: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 10:11: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 10:11:50 INFO - Downloading blessings-1.6.tar.gz 10:11:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 10:11:50 INFO - Installing collected packages: blessings 10:11:50 INFO - Running setup.py install for blessings 10:11:51 INFO - Successfully installed blessings 10:11:51 INFO - Cleaning up... 10:11:51 INFO - Return code: 0 10:11:51 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 10:11:51 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:11:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:11:51 INFO - Reading from file tmpfile_stdout 10:11:51 INFO - Current package versions: 10:11:51 INFO - argparse == 1.2.1 10:11:51 INFO - blessings == 1.6 10:11:51 INFO - blobuploader == 1.2.4 10:11:51 INFO - docopt == 0.6.1 10:11:51 INFO - manifestparser == 1.1 10:11:51 INFO - mozInstall == 1.12 10:11:51 INFO - mozcrash == 0.16 10:11:51 INFO - mozdebug == 0.1 10:11:51 INFO - mozdevice == 0.48 10:11:51 INFO - mozfile == 1.2 10:11:51 INFO - mozhttpd == 0.7 10:11:51 INFO - mozinfo == 0.9 10:11:51 INFO - mozleak == 0.1 10:11:51 INFO - mozlog == 3.1 10:11:51 INFO - moznetwork == 0.27 10:11:51 INFO - mozprocess == 0.22 10:11:51 INFO - mozprofile == 0.28 10:11:51 INFO - mozrunner == 6.11 10:11:51 INFO - mozscreenshot == 0.1 10:11:51 INFO - mozsystemmonitor == 0.0 10:11:51 INFO - moztest == 0.7 10:11:51 INFO - mozversion == 1.4 10:11:51 INFO - psutil == 3.1.1 10:11:51 INFO - requests == 1.2.3 10:11:51 INFO - wsgiref == 0.1.2 10:11:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:11:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2d3b749f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2812670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a18c0>, '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 0x28a27c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a2c50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1456941755.609493-1377747993', '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 10:11:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 10:11:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:11:51 INFO - Using env: {'DISPLAY': ':0', 10:11:51 INFO - 'HOME': '/home/cltbld', 10:11:51 INFO - 'LANG': 'en_US.UTF-8', 10:11:51 INFO - 'LANGUAGE': 'en_US:en', 10:11:51 INFO - 'LOGNAME': 'cltbld', 10:11:51 INFO - 'MAIL': '/var/mail/cltbld', 10:11:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:51 INFO - 'MOZ_NO_REMOTE': '1', 10:11:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:51 INFO - 'NO_EM_RESTART': '1', 10:11:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:11:51 INFO - 'PWD': '/builds/slave/test-pgo', 10:11:51 INFO - 'SHELL': '/bin/bash', 10:11:51 INFO - 'SHLVL': '1', 10:11:51 INFO - 'TERM': 'linux', 10:11:51 INFO - 'TMOUT': '86400', 10:11:51 INFO - 'USER': 'cltbld', 10:11:51 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1456941755.609493-1377747993', 10:11:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:51 INFO - '_': '/tools/buildbot/bin/python'} 10:11:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 10:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 10:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 10:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 10:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 10:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 10:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 10:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 10:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 10:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 10:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 10:11:51 INFO - Cleaning up... 10:11:51 INFO - Return code: 0 10:11:51 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 10:11:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2d3b749f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2812670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a18c0>, '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 0x28a27c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a2c50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1456941755.609493-1377747993', '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 10:11:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 10:11:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:11:51 INFO - Using env: {'DISPLAY': ':0', 10:11:51 INFO - 'HOME': '/home/cltbld', 10:11:51 INFO - 'LANG': 'en_US.UTF-8', 10:11:51 INFO - 'LANGUAGE': 'en_US:en', 10:11:51 INFO - 'LOGNAME': 'cltbld', 10:11:51 INFO - 'MAIL': '/var/mail/cltbld', 10:11:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:51 INFO - 'MOZ_NO_REMOTE': '1', 10:11:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:51 INFO - 'NO_EM_RESTART': '1', 10:11:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:11:51 INFO - 'PWD': '/builds/slave/test-pgo', 10:11:51 INFO - 'SHELL': '/bin/bash', 10:11:51 INFO - 'SHLVL': '1', 10:11:51 INFO - 'TERM': 'linux', 10:11:51 INFO - 'TMOUT': '86400', 10:11:51 INFO - 'USER': 'cltbld', 10:11:51 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1456941755.609493-1377747993', 10:11:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:51 INFO - '_': '/tools/buildbot/bin/python'} 10:11:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:51 INFO - Downloading/unpacking jsonschema 10:11: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 10:11: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 10:11: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 10:11: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 10:11: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 10:11: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 10:11:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:11:53 INFO - Downloading/unpacking functools32 (from jsonschema) 10:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:53 INFO - Downloading functools32-3.2.3-2.tar.gz 10:11:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 10:11:53 INFO - warning: no files found matching '*.txt' 10:11:53 INFO - no previously-included directories found matching 'build' 10:11:53 INFO - no previously-included directories found matching 'dist' 10:11:53 INFO - no previously-included directories found matching '.git*' 10:11:53 INFO - Installing collected packages: jsonschema, functools32 10:11:53 INFO - Running setup.py install for functools32 10:11:53 INFO - warning: no files found matching '*.txt' 10:11:53 INFO - no previously-included directories found matching 'build' 10:11:53 INFO - no previously-included directories found matching 'dist' 10:11:53 INFO - no previously-included directories found matching '.git*' 10:11:54 INFO - Successfully installed jsonschema functools32 10:11:54 INFO - Cleaning up... 10:11:54 INFO - Return code: 0 10:11:54 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 10:11:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2d3b749f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2812670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a18c0>, '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 0x28a27c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a2c50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1456941755.609493-1377747993', '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 10:11:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 10:11:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:11:54 INFO - Using env: {'DISPLAY': ':0', 10:11:54 INFO - 'HOME': '/home/cltbld', 10:11:54 INFO - 'LANG': 'en_US.UTF-8', 10:11:54 INFO - 'LANGUAGE': 'en_US:en', 10:11:54 INFO - 'LOGNAME': 'cltbld', 10:11:54 INFO - 'MAIL': '/var/mail/cltbld', 10:11:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:54 INFO - 'MOZ_NO_REMOTE': '1', 10:11:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:54 INFO - 'NO_EM_RESTART': '1', 10:11:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:11:54 INFO - 'PWD': '/builds/slave/test-pgo', 10:11:54 INFO - 'SHELL': '/bin/bash', 10:11:54 INFO - 'SHLVL': '1', 10:11:54 INFO - 'TERM': 'linux', 10:11:54 INFO - 'TMOUT': '86400', 10:11:54 INFO - 'USER': 'cltbld', 10:11:54 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1456941755.609493-1377747993', 10:11:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:54 INFO - '_': '/tools/buildbot/bin/python'} 10:11:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:54 INFO - Downloading/unpacking flake8 10:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:11:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:11:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 10:11:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:11:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:11:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:11:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:11:56 INFO - no previously-included directories found matching 'docs/_build' 10:11:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:11:56 INFO - Running setup.py install for pep8 10:11:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:11:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:11:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:11:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:11:56 INFO - no previously-included directories found matching 'docs/_build' 10:11:56 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 10:11:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:11:56 INFO - Cleaning up... 10:11:57 INFO - Return code: 0 10:11:57 INFO - Running post-action listener: _resource_record_post_action 10:11:57 INFO - Running post-action listener: _start_resource_monitoring 10:11:57 INFO - Starting resource monitoring. 10:11:57 INFO - ##### 10:11:57 INFO - ##### Running install step. 10:11:57 INFO - ##### 10:11:57 INFO - Running pre-action listener: _resource_record_pre_action 10:11:57 INFO - Running main action method: install 10:11:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:11:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:11:57 INFO - Reading from file tmpfile_stdout 10:11:57 INFO - Detecting whether we're running mozinstall >=1.0... 10:11:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 10:11:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 10:11:57 INFO - Reading from file tmpfile_stdout 10:11:57 INFO - Output received: 10:11:57 INFO - Usage: mozinstall [options] installer 10:11:57 INFO - Options: 10:11:57 INFO - -h, --help show this help message and exit 10:11:57 INFO - -d DEST, --destination=DEST 10:11:57 INFO - Directory to install application into. [default: 10:11:57 INFO - "/builds/slave/test-pgo"] 10:11:57 INFO - --app=APP Application being installed. [default: firefox] 10:11:57 INFO - mkdir: /builds/slave/test-pgo/build/application 10:11:57 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'] 10:11:57 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 10:12:13 INFO - Reading from file tmpfile_stdout 10:12:13 INFO - Output received: 10:12:13 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 10:12:13 INFO - Running post-action listener: _resource_record_post_action 10:12:13 INFO - ##### 10:12:13 INFO - ##### Running run-tests step. 10:12:13 INFO - ##### 10:12:13 INFO - Running pre-action listener: _resource_record_pre_action 10:12:13 INFO - Running main action method: run_tests 10:12:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 10:12:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 10:12:13 INFO - Python 2.7.3 10:12:13 INFO - Return code: 0 10:12:13 INFO - grabbing minidump binary from tooltool 10:12:13 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')]} 10:12:13 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 0x28a18c0>, '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 0x28a27c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a2c50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 10:12:13 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 10:12:13 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 10:12:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:12:13 INFO - Return code: 0 10:12:13 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 10:12:13 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 10:12:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 10:12:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 10:12:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 10:12:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 10:12:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 10:12:14 INFO - Return code: 0 10:12:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JORtoHwzRSamQmNe0h7r-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 10:12:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JORtoHwzRSamQmNe0h7r-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:12:14 INFO - Using env: {'DISPLAY': ':0', 10:12:14 INFO - 'HOME': '/home/cltbld', 10:12:14 INFO - 'LANG': 'en_US.UTF-8', 10:12:14 INFO - 'LANGUAGE': 'en_US:en', 10:12:14 INFO - 'LOGNAME': 'cltbld', 10:12:14 INFO - 'MAIL': '/var/mail/cltbld', 10:12:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:12:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 10:12:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:14 INFO - 'MOZ_NO_REMOTE': '1', 10:12:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:12:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:14 INFO - 'NO_EM_RESTART': '1', 10:12:14 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:12:14 INFO - 'PWD': '/builds/slave/test-pgo', 10:12:14 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 10:12:14 INFO - 'SHELL': '/bin/bash', 10:12:14 INFO - 'SHLVL': '1', 10:12:14 INFO - 'TERM': 'linux', 10:12:14 INFO - 'TMOUT': '86400', 10:12:14 INFO - 'USER': 'cltbld', 10:12:14 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1456941755.609493-1377747993', 10:12:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:14 INFO - '_': '/tools/buildbot/bin/python'} 10:12:14 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JORtoHwzRSamQmNe0h7r-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:12:14 INFO - mozversion application_buildid: 20160302073251 10:12:14 INFO - mozversion application_changeset: bdde3fedb45be528f985a0aff373b37b010fb927 10:12:14 INFO - mozversion application_display_name: Nightly 10:12:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:12:14 INFO - mozversion application_name: Firefox 10:12:14 INFO - mozversion application_remotingname: firefox 10:12:14 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:12:14 INFO - mozversion application_vendor: Mozilla 10:12:14 INFO - mozversion application_version: 47.0a1 10:12:14 INFO - mozversion platform_buildid: 20160302073251 10:12:14 INFO - mozversion platform_changeset: bdde3fedb45be528f985a0aff373b37b010fb927 10:12:14 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:12:14 INFO - mozversion platform_version: 47.0a1 10:12:14 INFO - using testdate: 1456942334 10:12:14 INFO - actual date: 1456942334 10:12:14 INFO - starting webserver on 'localhost:56238' 10:12:14 INFO - SUITE-START | Running 2 tests 10:12:14 INFO - TEST-START | dromaeo_css 10:12:14 INFO - operating with platform_type : linux_ 10:12:14 INFO - Initialising browser for dromaeo_css test... 10:12:14 INFO - TEST-INFO | started process 27217 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkvsgTO/profile http://localhost:56238/getInfo.html) 10:12:18 INFO - PROCESS | 27217 | 10:12:18 INFO - PROCESS | 27217 | (process:27299): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:12:19 INFO - PROCESS | 27217 | __metrics Screen width/height:1600/1200 10:12:19 INFO - PROCESS | 27217 | colorDepth:24 10:12:19 INFO - PROCESS | 27217 | Browser inner width/height: 1024/697 10:12:19 INFO - PROCESS | 27217 | __metrics 10:12:20 ERROR - PROCESS | 27217 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 10:12:21 INFO - TEST-INFO | 27217: exit 0 10:12:21 INFO - Browser initialized. 10:12:21 INFO - Running cycle 1/1 for dromaeo_css test... 10:12:21 INFO - TEST-INFO | started process 27350 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkvsgTO/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:12:22 INFO - PROCESS | 27350 | 10:12:22 INFO - PROCESS | 27350 | (process:27407): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:12:32 INFO - PROCESS | 27350 | RSS: Main: 161153024 10:12:32 INFO - PROCESS | 27350 | 10:13:22 INFO - PROCESS | 27350 | 1456942402550 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] 10:15:31 INFO - PROCESS | 27350 | Cycle 1(1): loaded http://localhost:56238/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56238/tests/dromaeo/cssquery-ext.html) 10:15:32 INFO - PROCESS | 27350 | RSS: Main: 169238528 10:15:32 INFO - PROCESS | 27350 | 10:18:34 INFO - PROCESS | 27350 | Cycle 1(1): loaded http://localhost:56238/tests/dromaeo/cssquery-ext.html (next: http://localhost:56238/tests/dromaeo/cssquery-jquery.html) 10:18:35 INFO - PROCESS | 27350 | RSS: Main: 165974016 10:18:35 INFO - PROCESS | 27350 | 10:21:36 INFO - PROCESS | 27350 | Cycle 1(1): loaded http://localhost:56238/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56238/tests/dromaeo/cssquery-mootools.html) 10:21:37 INFO - PROCESS | 27350 | RSS: Main: 166510592 10:21:37 INFO - PROCESS | 27350 | 10:24:39 INFO - PROCESS | 27350 | Cycle 1(1): loaded http://localhost:56238/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56238/tests/dromaeo/cssquery-prototype.html) 10:24:39 INFO - PROCESS | 27350 | RSS: Main: 163594240 10:24:39 INFO - PROCESS | 27350 | 10:27:41 INFO - PROCESS | 27350 | Cycle 1(1): loaded http://localhost:56238/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56238/tests/dromaeo/cssquery-yui.html) 10:27:42 INFO - PROCESS | 27350 | RSS: Main: 164614144 10:27:42 INFO - PROCESS | 27350 | 10:30:45 INFO - PROCESS | 27350 | Cycle 1(1): loaded http://localhost:56238/tests/dromaeo/cssquery-yui.html (next: http://localhost:56238/tests/dromaeo/cssquery-dojo.html) 10:30:45 INFO - PROCESS | 27350 | RSS: Main: 168534016 10:30:45 INFO - PROCESS | 27350 | 10:30:45 INFO - PROCESS | 27350 | __start_tp_report 10:30:45 INFO - PROCESS | 27350 | _x_x_mozilla_page_load 10:30:45 INFO - PROCESS | 27350 | _x_x_mozilla_page_load_details 10:30:45 INFO - PROCESS | 27350 | |i|pagename|runs| 10:30:45 INFO - PROCESS | 27350 | |0;dojo.html;3164.556962025318;3174.8888788892386;3202.1994501374656;3217.6138863336405;3234.85443155058;5196.220566914964;5203.661761985473;5214.243934629477;5232.790688372465;5306.814261500848;5184.455632158626;5214.878801057772;5228.529432351088;5255.395629502608;5258.237555554442;4693.976530117353;4709.64677649176;4756.07256584966;4758.547937945889;4827.131116399047;4744.07490539345;4749.52504749524;4816.205326121186;4826.396700412449;4837.830675926343;4763.571278584926;4808;4844.975775121137;4846.7818948147415;4867.537583929557;4797.208460604031;4802.735849528274;4826.61387089032;4851.975740121276;4856.150173719585;4701.247800351962;4727.101850648366;4782.641301902371;4823.638227132979;4871.488493708145;5122.564582010534;5148.227765835118;5175.689458632494;5194.039102766001;5198.376194856603;5660.971695141498;5685.289338832646;5685.630364446928;5686.545076393879;5691.402402747734;5611.158326251054;5613.326400831886;5671.716414179275;5684.261046063985;5770.913436298459;5224.294720212761;5246.055709972204;5248.685078895202;5265.052290587692;5283.682979021271;5667.716614169275;5667.914981275284;5667.943320566824;5689.061304884648;5720.570957178228;5366.812161574326;5473.534749546333;5503.091989821714;5575.163725441216;5603.215549823028;5530.087535556669;5551.417101204315;5570.2480165177185;5573.916391254134;5574.554035677136;5488.231647569343;5552.7223638817895;5567.109262517978;5586.050371436865;5623.915641265385;5479.726013699299;5562.833115006556;5578.41426650204;5599;5645.802396916089;4326.2212801696;4343.2399330117105;4343.326784348431;4346.630536404377;4378.299472084451;3881.1073453105378;3894.863679771251;3907.5897030811925;3921.450996860442;3952.5256969163884;5251.501107394792;5253.106971814801;5357.35711714589;5385.165299378603;5425.83722488326;5607.43925607436;5628.577856660767;5637.816058627652;5658.094704847204;5684.062129748628;5353.143497040455;5401.108817045144;5409.56723462122;5420.593455490854;5470.097433923438;4736.95263047372;4770.522947705202;4798.592119669867;4809.374781278411;4842.612590992712;5752.137179423036;5767.5674324425;5779.595428320062;5780.913286300709;5791.189233507313;5438.320209973754;5536.031194541019;5541.889162216652;5545.916811247754;5595.188697638901;5802.622829516068;5819.941800582109;5843.415658434123;5848.736806843617;5894;5428.809991650273;5447.073997420527;5449.591280654046;5456.127019676833;5465.152901300305;5490.286262785812;5523.779048838162;5535.418781027934;5536.806211782729;5545.889082218414;5433.022056029952;5452.672839629635;5495.477929596682;5530.944690553043;5571.192177134374;5423.3491980962535;5458.481444262948;5463.672179669233;5465.426130256265;5466.262054622575;5341.198820176849;5344.305240318734;5351.063563876384;5356;5439.184122381516;5464.235007099089;5465.7813687453645;5473.589480789036;5502.8349149525575;5521.033819081725;5299.072662284162;5347.1979203119845;5359.035373632783;5395.81114660985;5414.945850541444 10:30:45 INFO - PROCESS | 27350 | |1;ext.html;506.9442361340252;524.7035424984886;538.9164679474682;558.1376772885892;561.5058748301494;35870.46194307084;36509;36531.086722831875;36670;36700.44949325762;39449.80275098621;40257;40361.19277614453;40393.39409908854;40432;8400.075991640915;8602.483850968962;8615.612297446598;8618.827623447527;8641.567921603926;8506.702265420712;8626.137386261355;8638.136186381375;8825.95587022064;8830.911690883073;8755.78110547235;8817.338699597523;8829.337799665018;8860.8670869937;8894.42186257891;8761.824763504726;8770.6930257441;8819.911800881973;8856.645734170625;8870.201681848665;8666.956665216696;8721.084286149926;8725.607347669371;8807.559622018873;8823.338249631302;40191;40446.59553404458;40453.59546404528;40794.38808417876;40908.795456022825;2865.799394042418;3306.5205545195813;3312.840505822967;3431.6225215226304;3529.3823580873245;28152;28999.275018124717;29034.854825725946;29198.270043248875;29393.412131757457;3713.051545774697;3751.549814022335;3796.430535419709;3816.8664096756756;3855.1133239354826;239187;239307;239442.6055739438;240145;241261;41890.37164442536;42199;42324.730258092306;42708.78645606752;56167.15749263764;41188;41194.1761164775;41419.1716165681;41449.378259326135;41452.79273603673;15177.696446071017;15427.151506667016;15447.691046179238;15457.768133478006;15517.224138793015;12365.443555040045;12430.627081187398;12478.5008599655;12483.93758031204;12611.873881261254;14467.565973020826;14585.927070364793;14608.269586520631;14624.780628290584;14665.340059697339;5735.655860648374;5795.217645617788;5824.271966004249;5843.444872737083;5907.409259074144;951.1914872358578;1014.2443879309961;1036.2849633752687;1042.718466014172;1076.2520048566328;29000.7099928998;29092.55007364137;29485.410291794044;29813.40373192524;29816.40367192644;1044.4777611194402;1062.208654552348;1069.096613361708;1093.8796732359433;1208.6434501821984;14929.626759331104;15244;15317.157556334285;15571;15591.766123508156;321354;466846;470133;472256;475764;55811;57223.71388143116;57381;57382.85234295291;57475.71262143662;1373.6703191234233;1383;1391.0401822742479;1406.7045920356636;1506.021086293896;29819.701802981694;30946.381072377975;30992.690073099882;31315.686843131276;31623.683763162073;46650;47288.763556182;47331.526684732715;47387.52612473831;47543.286850696575;290423;296673.1996080242;297798;297854;298350;31966.200844979063;32150.35699286048;32205;32309.676903230666;32572.022839314857;42352.78823605862;42403.93990150271;43178.568214317456;43653.56346436495;43710.56289437192;35864.28271434609;36763.08092297714;36931.26137477289;37019.814900925325;37647.623523764414;35971.28057438889;36376.454353185254;36515.63484365122;37011.62988370082;37120.07199820026;36453.63546364608;36509.26981460303;38557.807210963765;39107.41338879976;39419.2116157681;29039;30496.695033050273;30904.690953090183;31924.962311432217;33164.66835331712;25453.3636659085;25460.490790184464;25480.362990925376;25564.616530751682;25598.488030238917 10:30:45 INFO - PROCESS | 27350 | |2;jquery.html;341.2645748412172;352.75836052304163;354.3816041008441;360.83221302094523;364.3369068295701;16624.750628740563;16631.41790037349;17163.485095447155;17180.055096969678;17226.138693065328;15853.445129420472;16139.354425822983;16560.171991400413;16565;16578.75131873023;5196.766145523451;5281.735913204344;5426.9185962210595;5532.225488431623;5532.446755324476;5389.299391079154;5391.245225668409;5447.509724124848;5471.261379713727;5491.341039075317;5115.181570948649;5321.600879934021;5409.702466364349;5412.702301373423;5429.728513574325;5265.7893684252585;5300.390455097675;5303.840884773444;5304.814331498398;5314.388845282765;5076.771545280434;5295.391030031518;5442.945570544283;5471.23402723619;5476.151196564539;12082.577109801116;12354.196977196543;12359.505619775287;14227.64430889236;20390.28633997803;2163.707899433572;2189.0587047569697;2330.6270996640455;2348.612478940973;2754.862256887148;12069;12378.504859805596;12410.317432541207;12526.123171378007;13139.34303284832;1826.1964735516462;1872.81271872813;1883.274939148424;1911.2928216559962;1938.1569017477443;68199.65900170516;69654.3034569653;69732.3026769731;70220.99999999949;71508;9826.950865245628;9920.255980801468;9988.450635214987;10018.699439016842;10171.4914254287;12994.220346779224;13011.674708132372;13100.344982751016;13125;13176.209427434385;7470.850582988419;7503.324700776956;7584.696612135453;7659.425543084291;7696.538207707556;7305.415566754753;7332.486725929134;7350.816229594303;7372.668229929559;7403;3925.4896863407575;4063.4108054331955;4356.346548017823;4484;4591.563801438858;1846.6399052184695;1869.3270422647836;1869.8597605179666;1887.6885313923324;1906.9427917162507;892.1569117184199;927.7495076329353;932.5337331334333;964.6671898195111;999.4952548962727;14967;16162.979627546556;16582.50252492427;16748.078855663054;17047.31810727557;929.149827907457;954.8949615542285;967.908048735369;985.6648739428629;986.9901300986899;9463.952680236554;9560.426374417557;9613;9631.133198012212;9798.706038818847;442959;458401;458571;466242;468552;73747;74711.25288747043;75171.24828751752;76723.61638191773;77389.6130519355;992;995.5619527407918;1005.0452070533023;1005.3063386263455;1027.2295778166226;14759;14907.701845963236;15088.849111509184;15137.394504220149;15245.542633721006;32389.35221295608;33082.83458582692;33272.83363583167;33432.665673342955;33690.32619347648;46205.76897115627;46876.29685554787;47273;47836.760816195696;48402.06391744431;7435.293647103516;7470.738524151629;7551.395888329031;7587.279208475186;7664.080310362792;11638.592649257236;12038.398080095785;12045.819312710491;12426;12538.247705137721;10488.26582139243;10580.629677961235;10646.20153488507;10985.285956412808;11058.834117488404;10520.631777887736;10536.525856336637;10695.572177112828;10986.560537578407;10997.560097596326;10851.131909447384;10922.781544369227;11219.60731374398;11226;11256.986871181633;7377.225391334047;7397.075365579302;7588.81027974305;7680.308772210527;8015.879761803694;10029.498525073863;10794.946025269823;10871.40207288575;11287.097032237565;11325.263857849213 10:30:45 INFO - PROCESS | 27350 | |3;mootools.html;1482.1996122094067;1497.4234919555968;1671.7158083125867;1784.4111443223737;1804.5097765084174;6666.933330666692;7299.89050164248;7318.926810731891;7486.887696684554;7510.62446877656;7347.118345798498;7376.483646144772;7417.703291868319;7445.8883116753295;7475.2151024142495;2167.0248388225323;2183.170395249803;2196.0117946923947;2198.582269368823;2204.8677079375207;2132.349633361824;2147.7744836792144;2196.6375548034557;2206.8124209442217;2211.7235345581803;2180.7928246816527;2189.813865821407;2190.7809219078126;2200.99854566172;2229.57638048771;2169.2841362350464;2173.402314363547;2174.0977494339986;2179.019441251435;2180.8255339572875;2149.505613708856;2181.083944743196;2186.0709198590534;2187.0377034104945;2194.9341519754435;7550.848983020363;7559;7563.130240022358;7566.356859666935;7569.318761311453;4425.645948324126;4461.397711308997;4461.776911154429;4502.8874278142985;4521.412216411845;2850.9287267818263;2890.7398334150025;2912.810667306618;2914.0674984005127;2945.3078526546246;937.5874615169304;978.1196922769493;984.5028260728358;1004.1213937804421;1009.7223263602494;9966.9501652492;10006.149477294439;10033.799324013478;10040.29717919746;10040.89959100407;4055.533613634411;4110.835566577303;4148.979255103765;4178.415021896937;4179.477565304337;8733.34499912509;8743.169398907094;8752.781180470412;8768.912310876809;8772.34207434445;4537.500874903758;4565.703229290086;4586.082783443325;4586.266197408466;4592.402987611589;3684.2263124743567;4068.2066996935905;4094.0788322627172;4153.397757325231;4211.663066954637;3476.66971637694;3496.3531746626445;3526.8589256429455;3541.8229088545468;3557.3418917500344;1067.9359238445563;1131.6491887514733;1144.2791041643877;1144.948477318506;1156.3582211872324;1332.5136325241217;1334.846492653338;1348.7100273441258;1365.9823431543366;1368.50733735855;6996.160460744743;7043.471739619549;7142.607156606333;7217.386522145676;7229.674664640103;1128.960486382989;1132.773445310941;1143.4168574027306;1162.7325715085408;1166.4692564882957;5611.6352437091455;5618.129189975561;5621.325440947113;5634.126710359901;5637.915431268452;8592.785180370416;8724.34567407447;9035.45787252767;9138.451692898447;9142.680006199884;8946.060663630355;8986.19124278818;9041.05068967762;9056;9085.227755640712;7019.122609673791;7090.149182098181;7095.773555641738;7123.394511466583;7153.642317884189;6829.897551536632;6846.246912839484;6862.588244705334;6866.141732283465;6873.037774711444;7848.882266765889;8041.718539851077;8098.3926205536;8109.675612975651;8131.7560473185895;8199.385046121684;8382.413231073766;8413.789655258668;8485.915140848512;8493.193146651058;6278.121063051085;6369.681515924278;6441.420272175339;6602.514434252447;6638.17022872141;7148.142222933281;7164.068671072727;7168.354848063699;7174.2108368078425;7239.058922340062;6279.183706118175;6293.244810622571;6358.650274234961;6510.414062734377;6590.736370545316;6337.366263373626;6377.74489020434;6414.166158399378;6437.7124575084235;6571.835704107436;6613.305602911817;6646.60120392778;6649.102371179829;6680.866382672417;6693.062971183941;6330.303666596578;6366.267879193767;6374.394432528902;6414.903776443264;6441.710123044568;6255.468285195628;6272.059191121369;6278.246610406781;6279.654618995999;6288.622682639057 10:30:45 INFO - PROCESS | 27350 | |4;prototype.html;330.32778296167305;331.7545016687651;334.4097667616657;336.2501621384313;340.83810190159676;6176.752929882805;6248.09402636618;6294.842628934279;6298.811035668931;6347.61914285142;6121.663308518041;6144.631322120676;6188.071789231618;6199.845003874905;6207.224096987877;4543.295789152687;4627.259638457847;4655.068986202756;4664.043871006453;4771.093492236472;4563.589276965073;4637.675362724611;4648.256278995362;4651.44182698075;4652.837150699726;4561.429821272341;4569.657275704319;4601.700889442175;4610.331501932218;4618.653600979923;4573.656975726817;4610.631149508032;4614.676972611918;4639.582437580634;4645.396098507173;3972;3985.4818873546255;3989.7606143631183;4005.0387906902424;4006.979965100156;5832.562557808139;5883.17635531026;5922.200502932092;5938.138969849348;5938.970305148489;5210.609204309654;5375.274337964363;5402.405735369106;5415.10650742627;5415.891682166334;6462.806115816533;6518.739250429977;6522.543421960465;6524.347565243485;6543.312952140052;4439;4445.288753799409;4448.866534003952;4457.153140903218;4462.3752674625575;6777.830554236134;6817.5568588042115;6852.5203235773515;6856.862862742717;6858.142732158481;4528.049109687003;4539.909201815945;4540.568645978627;4559.612432943237;4573.47405048417;4379.802908869108;4471.888202794956;4477;4481.731096134243;4627.884302892455;5274.736263186825;5275.419703832576;5279.947200528022;5318;5323.6273460857365;6430.678466076677;6546.0835483032415;6568.540202185801;6585.86828263432;6592.868142637216;1615.7414813629998;1635.4766474727974;1639.418006607661;1640.4750479846573;1643.2276829889934;1065.6057258814287;1081.351189286422;1090.7545802194443;1104.7127746785893;1107.9889201108047;6279.811605651837;6312.147860038928;6322.873542529215;6330.303666596671;6334.904976425358;6744.0895479109695;6753.594784312957;6756.932430675729;6760.797176084725;6778.864422711518;6223.066540019034;6269.529785266123;6322.430981211621;6376.776812811529;6402.551821372553;3686.705063594906;3703.3148867459604;3706.4625629283605;3707.1288247261873;3707.610700876423;7254.709811607477;7272.709091636381;7282.817929551804;7284.38082762971;7311.451641126937;6989.790306290819;7006.264342244093;7023.508354415142;7039.894401583981;7043.8239044023285;7068;7142.142942846787;7239.457040721862;7246.60143692102;7287.70849166038;6767.424768894502;6799.830004249933;6805.183377994672;6812.591244525344;6826.317368263134;6713.227978782503;6735.090762746966;6738.66306684654;6745.2242992056545;6772.729090836311;7221.386182174574;7225;7228.277172282729;7240.710371585077;7253.56478611285;4423.756693381895;4488.865334039984;4523;4540.977295113504;4541;6812.4890633203695;6846.315368463114;6858.5199036067;6871.9656401717675;6892;6590;6616.603003819786;6623.304553021863;6625.867482650224;6637.502187335873;6623.304553021863;6624.668766561749;6630.569013014331;6633.668316584248;6638.402543771083;6330.177076980147;6470.38531339522;6489.707963141575;6518.608883467007;6518.706658200487;6612.371824676648;6619.635920024445;6623.768168114093;6653.567518111307;6666.899996500153;6444.645544494911;6456.257530384066;6481.513886458629;6483.157189565326;6504.1869766279215 10:30:45 INFO - PROCESS | 27350 | |5;yui.html;679.4971720926515;687.4225650453618;754.4002517998191;788.5229436191108;794.3565711773467;13592.116512426684;13781.72436551271;13789.655258618539;13883.375248113834;13927.234002129879;12099.697507562316;12933.288669123194;13125.278109703962;13189.208647481159;13195.538156164535;826.5454000299826;835.7075023741672;844.1853611265128;844.6536919862857;845.5772113943028;830.8462934357133;833.2584000239791;834.8038211020405;836.0469065265572;838.1409055717877;871.4422769427572;874.396666300254;878.7319867440428;879.5821984557348;880.3529405886668;870.2254993056185;872.8036191856845;874.0254616103063;875.6322344615213;877.7893305606673;645.8579112595221;648.944839688627;651.6253154436218;652.8726898254843;653.2781276689237;12542.623721288375;12609;12654.620361389174;12662;12706.936465317707;11421.942890285578;11423;11539.134564907665;11595.884041159565;11671.562122590212;9391.436513809125;9403.952980235055;9521.095495927944;9685.70942871715;9812.313138080337;3476.7566270361085;3526.1713497328105;3541.663541963535;3604.8197590120653;3606.206634540397;49639.50360496385;49742.7512862437;49785.75107124441;49795.25307120396;49895.25157122646;8091.352691784643;8377.287930525852;10022.849657255147;10155.187584993182;10575.101116405192;18256.63486730258;18368.724469132972;18371.448856534324;18399.632007360047;18410.63178736418;7928.6035698214855;7931;8017.438779285394;8041.356691464669;8309.210624990616;4541.159885421208;4612.377329060601;4632.073585282957;4671.205894997858;4675.812967481263;3177.539256807796;3209.1335339458215;3221.710046095816;3222.4844024955896;3224.967750322514;561.7921369093461;563.6477201748907;566.9092945128759;569.0780934885512;583.4369833111068;616.6022915219659;631.8799428108645;642.4321492814651;644.4683136412385;652.9510286728514;7982.760517184378;8156.1028286888395;8241.752747417588;8326.70856520019;8521.701740439055;537.0199386120346;592.6207227374484;601.0653433910311;612.2805703298607;660.3495556876472;3854.1328201155075;3890.183061557048;3954.228925359585;3988.7008474363956;4001.7198796083994;58067;59317.70341148267;59418.702906486054;59676;60055.39944600585;43592.56407435885;50864.23703644448;51470.742646287275;52603.73698131485;52648.73675631597;44161.33757993633;44234.77882610566;45980;46030.76984615123;46258.537414625425;8271.379646526415;8313.501189928624;8415.789605259917;8616.43993140469;8644.827103458021;35010.64989350074;35070.649293506736;36128.27743445064;36614.63385366112;36790.63209367872;40237.19525609413;43842.56157438512;45274.54725452703;45661.77169114133;46127.53872461367;9622;9719.611215551298;10309.639162629272;10463.267571269938;10473.21450891171;11527.308361498337;11823.586174483851;11966.162368634112;12194.634160975185;12364.134510584172;10243.887883188696;10419.843702344318;10534.262601617813;10563.366198028143;10946.288491248044;10529.42088185157;10809.945950270197;10856;10917.072048875934;11279.266847654877;10278.948605256926;10348.22388320894;10422.166226701996;10784.029437350677;10785;9005.729828105168;9192.49441280736;9262.907370926205;9468.431894086378;9638.277129215197;7761.051753584719;8085.231902969209;8321.54231517248;8681.696140635047;8711.825763484821 10:30:45 INFO - PROCESS | 27350 | __end_tp_report 10:30:45 INFO - PROCESS | 27350 | __start_cc_report 10:30:45 INFO - PROCESS | 27350 | _x_x_mozilla_cycle_collect,311 10:30:45 INFO - PROCESS | 27350 | __end_cc_report 10:30:45 INFO - PROCESS | 27350 | __startTimestamp1456943445311__endTimestamp 10:30:45 INFO - PROCESS | 27350 | 10:30:45 INFO - PROCESS | 27350 | ------- Summary: start ------- 10:30:45 INFO - PROCESS | 27350 | Number of tests: 6 10:30:45 INFO - PROCESS | 27350 | 10:30:45 INFO - PROCESS | 27350 | [#0] dojo.html Cycles:165 Average:5212.83 Median:5420.59 stddev:557.07 (10.3%) stddev-sans-first:535.10 10:30:45 INFO - PROCESS | 27350 | Values: 3164.6 3174.9 3202.2 3217.6 3234.9 5196.2 5203.7 5214.2 5232.8 5306.8 5184.5 5214.9 5228.5 5255.4 5258.2 4694.0 4709.6 4756.1 4758.5 4827.1 4744.1 4749.5 4816.2 4826.4 4837.8 4763.6 4808.0 4845.0 4846.8 4867.5 4797.2 4802.7 4826.6 4852.0 4856.2 4701.2 4727.1 4782.6 4823.6 4871.5 5122.6 5148.2 5175.7 5194.0 5198.4 5661.0 5685.3 5685.6 5686.5 5691.4 5611.2 5613.3 5671.7 5684.3 5770.9 5224.3 5246.1 5248.7 5265.1 5283.7 5667.7 5667.9 5667.9 5689.1 5720.6 5366.8 5473.5 5503.1 5575.2 5603.2 5530.1 5551.4 5570.2 5573.9 5574.6 5488.2 5552.7 5567.1 5586.1 5623.9 5479.7 5562.8 5578.4 5599.0 5645.8 4326.2 4343.2 4343.3 4346.6 4378.3 3881.1 3894.9 3907.6 3921.5 3952.5 5251.5 5253.1 5357.4 5385.2 5425.8 5607.4 5628.6 5637.8 5658.1 5684.1 5353.1 5401.1 5409.6 5420.6 5470.1 4737.0 4770.5 4798.6 4809.4 4842.6 5752.1 5767.6 5779.6 5780.9 5791.2 5438.3 5536.0 5541.9 5545.9 5595.2 5802.6 5819.9 5843.4 5848.7 5894.0 5428.8 5447.1 5449.6 5456.1 5465.2 5490.3 5523.8 5535.4 5536.8 5545.9 5433.0 5452.7 5495.5 5530.9 5571.2 5423.3 5458.5 5463.7 5465.4 5466.3 5341.2 5344.3 5351.1 5356.0 5439.2 5464.2 5465.8 5473.6 5502.8 5521.0 5299.1 5347.2 5359.0 5395.8 5414.9 10:30:45 INFO - PROCESS | 27350 | 10:30:45 INFO - PROCESS | 27350 | [#1] ext.html Cycles:180 Average:48232.78 Median:36731.77 stddev:89430.00 (243.5%) stddev-sans-first:89609.08 10:30:45 INFO - PROCESS | 27350 | Values: 506.9 524.7 538.9 558.1 561.5 35870.5 36509.0 36531.1 36670.0 36700.4 39449.8 40257.0 40361.2 40393.4 40432.0 8400.1 8602.5 8615.6 8618.8 8641.6 8506.7 8626.1 8638.1 8826.0 8830.9 8755.8 8817.3 8829.3 8860.9 8894.4 8761.8 8770.7 8819.9 8856.6 8870.2 8667.0 8721.1 8725.6 8807.6 8823.3 40191.0 40446.6 40453.6 40794.4 40908.8 2865.8 3306.5 3312.8 3431.6 3529.4 28152.0 28999.3 29034.9 29198.3 29393.4 3713.1 3751.5 3796.4 3816.9 3855.1 239187.0 239307.0 239442.6 240145.0 241261.0 41890.4 42199.0 42324.7 42708.8 56167.2 41188.0 41194.2 41419.2 41449.4 41452.8 15177.7 15427.2 15447.7 15457.8 15517.2 12365.4 12430.6 12478.5 12483.9 12611.9 14467.6 14585.9 14608.3 14624.8 14665.3 5735.7 5795.2 5824.3 5843.4 5907.4 951.2 1014.2 1036.3 1042.7 1076.3 29000.7 29092.6 29485.4 29813.4 29816.4 1044.5 1062.2 1069.1 1093.9 1208.6 14929.6 15244.0 15317.2 15571.0 15591.8 321354.0 466846.0 470133.0 472256.0 475764.0 55811.0 57223.7 57381.0 57382.9 57475.7 1373.7 1383.0 1391.0 1406.7 1506.0 29819.7 30946.4 30992.7 31315.7 31623.7 46650.0 47288.8 47331.5 47387.5 47543.3 290423.0 296673.2 297798.0 297854.0 298350.0 31966.2 32150.4 32205.0 32309.7 32572.0 42352.8 42403.9 43178.6 43653.6 43710.6 35864.3 36763.1 36931.3 37019.8 37647.6 35971.3 36376.5 36515.6 37011.6 37120.1 36453.6 36509.3 38557.8 39107.4 39419.2 29039.0 30496.7 30904.7 31925.0 33164.7 25453.4 25460.5 25480.4 25564.6 25598.5 10:30:45 INFO - PROCESS | 27350 | 10:30:45 INFO - PROCESS | 27350 | [#2] jquery.html Cycles:180 Average:25975.71 Median:3994.45 stddev:75331.13 (1885.9%) stddev-sans-first:75517.86 10:30:45 INFO - PROCESS | 27350 | Values: 341.3 352.8 354.4 360.8 364.3 16624.8 16631.4 17163.5 17180.1 17226.1 15853.4 16139.4 16560.2 16565.0 16578.8 5196.8 5281.7 5426.9 5532.2 5532.4 5389.3 5391.2 5447.5 5471.3 5491.3 5115.2 5321.6 5409.7 5412.7 5429.7 5265.8 5300.4 5303.8 5304.8 5314.4 5076.8 5295.4 5442.9 5471.2 5476.2 12082.6 12354.2 12359.5 14227.6 20390.3 2163.7 2189.1 2330.6 2348.6 2754.9 12069.0 12378.5 12410.3 12526.1 13139.3 1826.2 1872.8 1883.3 1911.3 1938.2 68199.7 69654.3 69732.3 70221.0 71508.0 9827.0 9920.3 9988.5 10018.7 10171.5 12994.2 13011.7 13100.3 13125.0 13176.2 7470.9 7503.3 7584.7 7659.4 7696.5 7305.4 7332.5 7350.8 7372.7 7403.0 3925.5 4063.4 4356.3 4484.0 4591.6 1846.6 1869.3 1869.9 1887.7 1906.9 892.2 927.7 932.5 964.7 999.5 14967.0 16163.0 16582.5 16748.1 17047.3 929.1 954.9 967.9 985.7 987.0 9464.0 9560.4 9613.0 9631.1 9798.7 442959.0 458401.0 458571.0 466242.0 468552.0 73747.0 74711.3 75171.2 76723.6 77389.6 992.0 995.6 1005.0 1005.3 1027.2 14759.0 14907.7 15088.8 15137.4 15245.5 32389.4 33082.8 33272.8 33432.7 33690.3 46205.8 46876.3 47273.0 47836.8 48402.1 7435.3 7470.7 7551.4 7587.3 7664.1 11638.6 12038.4 12045.8 12426.0 12538.2 10488.3 10580.6 10646.2 10985.3 11058.8 10520.6 10536.5 10695.6 10986.6 10997.6 10851.1 10922.8 11219.6 11226.0 11257.0 7377.2 7397.1 7588.8 7680.3 8015.9 10029.5 10794.9 10871.4 11287.1 11325.3 10:30:45 INFO - PROCESS | 27350 | 10:30:45 INFO - PROCESS | 27350 | [#3] mootools.html Cycles:180 Average:5242.19 Median:6279.42 stddev:2674.92 (42.6%) stddev-sans-first:2667.49 10:30:45 INFO - PROCESS | 27350 | Values: 1482.2 1497.4 1671.7 1784.4 1804.5 6666.9 7299.9 7318.9 7486.9 7510.6 7347.1 7376.5 7417.7 7445.9 7475.2 2167.0 2183.2 2196.0 2198.6 2204.9 2132.3 2147.8 2196.6 2206.8 2211.7 2180.8 2189.8 2190.8 2201.0 2229.6 2169.3 2173.4 2174.1 2179.0 2180.8 2149.5 2181.1 2186.1 2187.0 2194.9 7550.8 7559.0 7563.1 7566.4 7569.3 4425.6 4461.4 4461.8 4502.9 4521.4 2850.9 2890.7 2912.8 2914.1 2945.3 937.6 978.1 984.5 1004.1 1009.7 9967.0 10006.1 10033.8 10040.3 10040.9 4055.5 4110.8 4149.0 4178.4 4179.5 8733.3 8743.2 8752.8 8768.9 8772.3 4537.5 4565.7 4586.1 4586.3 4592.4 3684.2 4068.2 4094.1 4153.4 4211.7 3476.7 3496.4 3526.9 3541.8 3557.3 1067.9 1131.6 1144.3 1144.9 1156.4 1332.5 1334.8 1348.7 1366.0 1368.5 6996.2 7043.5 7142.6 7217.4 7229.7 1129.0 1132.8 1143.4 1162.7 1166.5 5611.6 5618.1 5621.3 5634.1 5637.9 8592.8 8724.3 9035.5 9138.5 9142.7 8946.1 8986.2 9041.1 9056.0 9085.2 7019.1 7090.1 7095.8 7123.4 7153.6 6829.9 6846.2 6862.6 6866.1 6873.0 7848.9 8041.7 8098.4 8109.7 8131.8 8199.4 8382.4 8413.8 8485.9 8493.2 6278.1 6369.7 6441.4 6602.5 6638.2 7148.1 7164.1 7168.4 7174.2 7239.1 6279.2 6293.2 6358.7 6510.4 6590.7 6337.4 6377.7 6414.2 6437.7 6571.8 6613.3 6646.6 6649.1 6680.9 6693.1 6330.3 6366.3 6374.4 6414.9 6441.7 6255.5 6272.1 6278.2 6279.7 6288.6 10:30:45 INFO - PROCESS | 27350 | 10:30:45 INFO - PROCESS | 27350 | [#4] prototype.html Cycles:180 Average:5485.65 Median:6296.83 stddev:1704.07 (27.1%) stddev-sans-first:1664.34 10:30:45 INFO - PROCESS | 27350 | Values: 330.3 331.8 334.4 336.3 340.8 6176.8 6248.1 6294.8 6298.8 6347.6 6121.7 6144.6 6188.1 6199.8 6207.2 4543.3 4627.3 4655.1 4664.0 4771.1 4563.6 4637.7 4648.3 4651.4 4652.8 4561.4 4569.7 4601.7 4610.3 4618.7 4573.7 4610.6 4614.7 4639.6 4645.4 3972.0 3985.5 3989.8 4005.0 4007.0 5832.6 5883.2 5922.2 5938.1 5939.0 5210.6 5375.3 5402.4 5415.1 5415.9 6462.8 6518.7 6522.5 6524.3 6543.3 4439.0 4445.3 4448.9 4457.2 4462.4 6777.8 6817.6 6852.5 6856.9 6858.1 4528.0 4539.9 4540.6 4559.6 4573.5 4379.8 4471.9 4477.0 4481.7 4627.9 5274.7 5275.4 5279.9 5318.0 5323.6 6430.7 6546.1 6568.5 6585.9 6592.9 1615.7 1635.5 1639.4 1640.5 1643.2 1065.6 1081.4 1090.8 1104.7 1108.0 6279.8 6312.1 6322.9 6330.3 6334.9 6744.1 6753.6 6756.9 6760.8 6778.9 6223.1 6269.5 6322.4 6376.8 6402.6 3686.7 3703.3 3706.5 3707.1 3707.6 7254.7 7272.7 7282.8 7284.4 7311.5 6989.8 7006.3 7023.5 7039.9 7043.8 7068.0 7142.1 7239.5 7246.6 7287.7 6767.4 6799.8 6805.2 6812.6 6826.3 6713.2 6735.1 6738.7 6745.2 6772.7 7221.4 7225.0 7228.3 7240.7 7253.6 4423.8 4488.9 4523.0 4541.0 4541.0 6812.5 6846.3 6858.5 6872.0 6892.0 6590.0 6616.6 6623.3 6625.9 6637.5 6623.3 6624.7 6630.6 6633.7 6638.4 6330.2 6470.4 6489.7 6518.6 6518.7 6612.4 6619.6 6623.8 6653.6 6666.9 6444.6 6456.3 6481.5 6483.2 6504.2 10:30:45 INFO - PROCESS | 27350 | 10:30:45 INFO - PROCESS | 27350 | [#5] yui.html Cycles:180 Average:13649.80 Median:49845.25 stddev:16126.66 (32.4%) stddev-sans-first:16142.48 10:30:45 INFO - PROCESS | 27350 | Values: 679.5 687.4 754.4 788.5 794.4 13592.1 13781.7 13789.7 13883.4 13927.2 12099.7 12933.3 13125.3 13189.2 13195.5 826.5 835.7 844.2 844.7 845.6 830.8 833.3 834.8 836.0 838.1 871.4 874.4 878.7 879.6 880.4 870.2 872.8 874.0 875.6 877.8 645.9 648.9 651.6 652.9 653.3 12542.6 12609.0 12654.6 12662.0 12706.9 11421.9 11423.0 11539.1 11595.9 11671.6 9391.4 9404.0 9521.1 9685.7 9812.3 3476.8 3526.2 3541.7 3604.8 3606.2 49639.5 49742.8 49785.8 49795.3 49895.3 8091.4 8377.3 10022.8 10155.2 10575.1 18256.6 18368.7 18371.4 18399.6 18410.6 7928.6 7931.0 8017.4 8041.4 8309.2 4541.2 4612.4 4632.1 4671.2 4675.8 3177.5 3209.1 3221.7 3222.5 3225.0 561.8 563.6 566.9 569.1 583.4 616.6 631.9 642.4 644.5 653.0 7982.8 8156.1 8241.8 8326.7 8521.7 537.0 592.6 601.1 612.3 660.3 3854.1 3890.2 3954.2 3988.7 4001.7 58067.0 59317.7 59418.7 59676.0 60055.4 43592.6 50864.2 51470.7 52603.7 52648.7 44161.3 44234.8 45980.0 46030.8 46258.5 8271.4 8313.5 8415.8 8616.4 8644.8 35010.6 35070.6 36128.3 36614.6 36790.6 40237.2 43842.6 45274.5 45661.8 46127.5 9622.0 9719.6 10309.6 10463.3 10473.2 11527.3 11823.6 11966.2 12194.6 12364.1 10243.9 10419.8 10534.3 10563.4 10946.3 10529.4 10809.9 10856.0 10917.1 11279.3 10278.9 10348.2 10422.2 10784.0 10785.0 9005.7 9192.5 9262.9 9468.4 9638.3 7761.1 8085.2 8321.5 8681.7 8711.8 10:30:45 INFO - PROCESS | 27350 | -------- Summary: end -------- 10:30:45 INFO - PROCESS | 27350 | 10:30:45 INFO - TEST-INFO | 27350: exit 0 10:30:46 INFO - TEST-OK | dromaeo_css | took 1111230ms 10:30:46 INFO - TEST-START | kraken 10:30:46 INFO - operating with platform_type : linux_ 10:30:46 INFO - Initialising browser for kraken test... 10:30:46 INFO - TEST-INFO | started process 27592 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0Zirt7/profile http://localhost:56238/getInfo.html) 10:30:49 INFO - PROCESS | 27592 | 10:30:49 INFO - PROCESS | 27592 | (process:27665): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:30:50 INFO - PROCESS | 27592 | __metrics Screen width/height:1600/1200 10:30:50 INFO - PROCESS | 27592 | colorDepth:24 10:30:50 INFO - PROCESS | 27592 | Browser inner width/height: 1024/697 10:30:50 INFO - PROCESS | 27592 | __metrics 10:30:51 ERROR - PROCESS | 27592 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 10:30:52 INFO - TEST-INFO | 27592: exit 0 10:30:52 INFO - Browser initialized. 10:30:52 INFO - Running cycle 1/1 for kraken test... 10:30:52 INFO - TEST-INFO | started process 27716 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0Zirt7/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:30:53 INFO - PROCESS | 27716 | 10:30:53 INFO - PROCESS | 27716 | (process:27775): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:31:04 INFO - PROCESS | 27716 | RSS: Main: 161374208 10:31:04 INFO - PROCESS | 27716 | 10:31:06 INFO - PROCESS | 27716 | Cycle 1(1): loaded http://localhost:56238/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56238/tests/kraken/driver.html?testName=audio-beat-detection) 10:31:07 INFO - PROCESS | 27716 | RSS: Main: 168087552 10:31:07 INFO - PROCESS | 27716 | 10:31:09 INFO - PROCESS | 27716 | Cycle 1(1): loaded http://localhost:56238/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56238/tests/kraken/driver.html?testName=audio-dft) 10:31:10 INFO - PROCESS | 27716 | RSS: Main: 170299392 10:31:10 INFO - PROCESS | 27716 | 10:31:13 INFO - PROCESS | 27716 | Cycle 1(1): loaded http://localhost:56238/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56238/tests/kraken/driver.html?testName=audio-fft) 10:31:13 INFO - PROCESS | 27716 | RSS: Main: 164454400 10:31:13 INFO - PROCESS | 27716 | 10:31:15 INFO - PROCESS | 27716 | Cycle 1(1): loaded http://localhost:56238/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56238/tests/kraken/driver.html?testName=audio-oscillator) 10:31:16 INFO - PROCESS | 27716 | RSS: Main: 165863424 10:31:16 INFO - PROCESS | 27716 | 10:31:18 INFO - PROCESS | 27716 | Cycle 1(1): loaded http://localhost:56238/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56238/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:31:19 INFO - PROCESS | 27716 | RSS: Main: 165666816 10:31:19 INFO - PROCESS | 27716 | 10:31:22 INFO - PROCESS | 27716 | Cycle 1(1): loaded http://localhost:56238/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56238/tests/kraken/driver.html?testName=imaging-darkroom) 10:31:23 INFO - PROCESS | 27716 | RSS: Main: 165392384 10:31:23 INFO - PROCESS | 27716 | 10:31:26 INFO - PROCESS | 27716 | Cycle 1(1): loaded http://localhost:56238/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56238/tests/kraken/driver.html?testName=imaging-desaturate) 10:31:26 INFO - PROCESS | 27716 | RSS: Main: 165879808 10:31:26 INFO - PROCESS | 27716 | 10:31:29 INFO - PROCESS | 27716 | Cycle 1(1): loaded http://localhost:56238/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56238/tests/kraken/driver.html?testName=json-parse-financial) 10:31:30 INFO - PROCESS | 27716 | RSS: Main: 166219776 10:31:30 INFO - PROCESS | 27716 | 10:31:31 INFO - PROCESS | 27716 | Cycle 1(1): loaded http://localhost:56238/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56238/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:31:32 INFO - PROCESS | 27716 | RSS: Main: 166027264 10:31:32 INFO - PROCESS | 27716 | 10:31:34 INFO - PROCESS | 27716 | Cycle 1(1): loaded http://localhost:56238/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56238/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:31:34 INFO - PROCESS | 27716 | RSS: Main: 166768640 10:31:34 INFO - PROCESS | 27716 | 10:31:37 INFO - PROCESS | 27716 | Cycle 1(1): loaded http://localhost:56238/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56238/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:31:37 INFO - PROCESS | 27716 | RSS: Main: 167079936 10:31:37 INFO - PROCESS | 27716 | 10:31:40 INFO - PROCESS | 27716 | Cycle 1(1): loaded http://localhost:56238/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56238/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:31:40 INFO - PROCESS | 27716 | RSS: Main: 165232640 10:31:40 INFO - PROCESS | 27716 | 10:31:43 INFO - PROCESS | 27716 | Cycle 1(1): loaded http://localhost:56238/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56238/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:31:43 INFO - PROCESS | 27716 | RSS: Main: 166637568 10:31:43 INFO - PROCESS | 27716 | 10:31:45 INFO - PROCESS | 27716 | Cycle 1(1): loaded http://localhost:56238/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56238/tests/kraken/driver.html?testName=ai-astar) 10:31:45 INFO - PROCESS | 27716 | RSS: Main: 167026688 10:31:45 INFO - PROCESS | 27716 | 10:31:45 INFO - PROCESS | 27716 | __start_tp_report 10:31:45 INFO - PROCESS | 27716 | _x_x_mozilla_page_load 10:31:45 INFO - PROCESS | 27716 | _x_x_mozilla_page_load_details 10:31:45 INFO - PROCESS | 27716 | |i|pagename|runs| 10:31:45 INFO - PROCESS | 27716 | |0;ai-astar;110;105;111;111;110;121;113;110;111;110 10:31:45 INFO - PROCESS | 27716 | |1;audio-beat-detection;155;136;160;168;130;167;158;131;169;130 10:31:45 INFO - PROCESS | 27716 | |2;audio-dft;163;163;163;162;165;163;163;167;168;162 10:31:45 INFO - PROCESS | 27716 | |3;audio-fft;77;75;76;76;75;76;73;144;74;75 10:31:45 INFO - PROCESS | 27716 | |4;audio-oscillator;94;94;142;93;94;93;144;94;93;142 10:31:45 INFO - PROCESS | 27716 | |5;imaging-gaussian-blur;117;118;117;118;118;118;117;117;117;118 10:31:45 INFO - PROCESS | 27716 | |6;imaging-darkroom;146;145;145;148;147;147;146;146;147;146 10:31:45 INFO - PROCESS | 27716 | |7;imaging-desaturate;96;97;96;97;96;96;95;96;97;95 10:31:45 INFO - PROCESS | 27716 | |8;json-parse-financial;58;56;57;60;56;57;56;56;57;53 10:31:45 INFO - PROCESS | 27716 | |9;json-stringify-tinderbox;67;67;67;67;67;67;67;68;67;68 10:31:45 INFO - PROCESS | 27716 | |10;stanford-crypto-aes;83;85;84;84;82;82;91;83;84;83 10:31:45 INFO - PROCESS | 27716 | |11;stanford-crypto-ccm;116;127;118;117;123;118;130;124;117;125 10:31:45 INFO - PROCESS | 27716 | |12;stanford-crypto-pbkdf2;148;151;152;152;152;140;151;162;150;141 10:31:45 INFO - PROCESS | 27716 | |13;stanford-crypto-sha256-iterative;68;69;74;68;72;68;69;68;71;73 10:31:45 INFO - PROCESS | 27716 | __end_tp_report 10:31:45 INFO - PROCESS | 27716 | __start_cc_report 10:31:45 INFO - PROCESS | 27716 | _x_x_mozilla_cycle_collect,803 10:31:45 INFO - PROCESS | 27716 | __end_cc_report 10:31:45 INFO - PROCESS | 27716 | __startTimestamp1456943505889__endTimestamp 10:31:45 INFO - PROCESS | 27716 | 10:31:45 INFO - PROCESS | 27716 | ------- Summary: start ------- 10:31:45 INFO - PROCESS | 27716 | Number of tests: 14 10:31:45 INFO - PROCESS | 27716 | 10:31:45 INFO - PROCESS | 27716 | [#0] ai-astar Cycles:10 Average:111.20 Median:111.00 stddev:3.99 (3.6%) stddev-sans-first:4.21 10:31:45 INFO - PROCESS | 27716 | Values: 110.0 105.0 111.0 111.0 110.0 121.0 113.0 110.0 111.0 110.0 10:31:45 INFO - PROCESS | 27716 | 10:31:45 INFO - PROCESS | 27716 | [#1] audio-beat-detection Cycles:10 Average:150.40 Median:159.00 stddev:16.73 (10.5%) stddev-sans-first:17.66 10:31:45 INFO - PROCESS | 27716 | Values: 155.0 136.0 160.0 168.0 130.0 167.0 158.0 131.0 169.0 130.0 10:31:45 INFO - PROCESS | 27716 | 10:31:45 INFO - PROCESS | 27716 | [#2] audio-dft Cycles:10 Average:163.90 Median:163.00 stddev:2.08 (1.3%) stddev-sans-first:2.18 10:31:45 INFO - PROCESS | 27716 | Values: 163.0 163.0 163.0 162.0 165.0 163.0 163.0 167.0 168.0 162.0 10:31:45 INFO - PROCESS | 27716 | 10:31:45 INFO - PROCESS | 27716 | [#3] audio-fft Cycles:10 Average:82.10 Median:75.50 stddev:21.78 (28.8%) stddev-sans-first:23.02 10:31:45 INFO - PROCESS | 27716 | Values: 77.0 75.0 76.0 76.0 75.0 76.0 73.0 144.0 74.0 75.0 10:31:45 INFO - PROCESS | 27716 | 10:31:45 INFO - PROCESS | 27716 | [#4] audio-oscillator Cycles:10 Average:108.30 Median:93.50 stddev:23.73 (25.4%) stddev-sans-first:24.59 10:31:45 INFO - PROCESS | 27716 | Values: 94.0 94.0 142.0 93.0 94.0 93.0 144.0 94.0 93.0 142.0 10:31:45 INFO - PROCESS | 27716 | 10:31:45 INFO - PROCESS | 27716 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 10:31:45 INFO - PROCESS | 27716 | Values: 117.0 118.0 117.0 118.0 118.0 118.0 117.0 117.0 117.0 118.0 10:31:45 INFO - PROCESS | 27716 | 10:31:45 INFO - PROCESS | 27716 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.50 stddev:0.95 (0.6%) stddev-sans-first:1.00 10:31:45 INFO - PROCESS | 27716 | Values: 146.0 145.0 145.0 148.0 147.0 147.0 146.0 146.0 147.0 146.0 10:31:45 INFO - PROCESS | 27716 | 10:31:45 INFO - PROCESS | 27716 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 10:31:45 INFO - PROCESS | 27716 | Values: 96.0 97.0 96.0 97.0 96.0 96.0 95.0 96.0 97.0 95.0 10:31:45 INFO - PROCESS | 27716 | 10:31:45 INFO - PROCESS | 27716 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:57.00 stddev:1.78 (3.1%) stddev-sans-first:1.81 10:31:45 INFO - PROCESS | 27716 | Values: 58.0 56.0 57.0 60.0 56.0 57.0 56.0 56.0 57.0 53.0 10:31:45 INFO - PROCESS | 27716 | 10:31:45 INFO - PROCESS | 27716 | [#9] json-stringify-tinderbox Cycles:10 Average:67.20 Median:67.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 10:31:45 INFO - PROCESS | 27716 | Values: 67.0 67.0 67.0 67.0 67.0 67.0 67.0 68.0 67.0 68.0 10:31:45 INFO - PROCESS | 27716 | 10:31:45 INFO - PROCESS | 27716 | [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:84.00 stddev:2.60 (3.1%) stddev-sans-first:2.73 10:31:45 INFO - PROCESS | 27716 | Values: 83.0 85.0 84.0 84.0 82.0 82.0 91.0 83.0 84.0 83.0 10:31:45 INFO - PROCESS | 27716 | 10:31:45 INFO - PROCESS | 27716 | [#11] stanford-crypto-ccm Cycles:10 Average:121.50 Median:123.50 stddev:4.93 (4.0%) stddev-sans-first:4.81 10:31:45 INFO - PROCESS | 27716 | Values: 116.0 127.0 118.0 117.0 123.0 118.0 130.0 124.0 117.0 125.0 10:31:45 INFO - PROCESS | 27716 | 10:31:45 INFO - PROCESS | 27716 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.90 Median:151.50 stddev:6.17 (4.1%) stddev-sans-first:6.51 10:31:45 INFO - PROCESS | 27716 | Values: 148.0 151.0 152.0 152.0 152.0 140.0 151.0 162.0 150.0 141.0 10:31:45 INFO - PROCESS | 27716 | 10:31:45 INFO - PROCESS | 27716 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:70.00 stddev:2.31 (3.3%) stddev-sans-first:2.33 10:31:45 INFO - PROCESS | 27716 | Values: 68.0 69.0 74.0 68.0 72.0 68.0 69.0 68.0 71.0 73.0 10:31:45 INFO - PROCESS | 27716 | -------- Summary: end -------- 10:31:45 INFO - PROCESS | 27716 | 10:31:46 INFO - TEST-INFO | 27716: exit 0 10:31:46 INFO - TEST-OK | kraken | took 60799ms 10:31:46 INFO - SUITE-END | took 1172s 10:31:47 INFO - Completed test suite (00:19:32) 10:31:47 INFO - Working with test: dromaeo_css 10:31:47 INFO - Generating results file: dromaeo_css 10:31:47 INFO - Working with test: kraken 10:31:47 INFO - Generating results file: kraken 10:31:47 INFO - javascript benchmark 10:31:47 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:31:47 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 10:31:47 INFO - process_Request line: dromaeo_css 6860.15 graph.html#tests=[[72,1,43]] 10:31:47 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:31:47 INFO - process_Request line: kraken 1525.10 graph.html#tests=[[232,1,43]] 10:31:47 INFO - RETURN: dromaeo_css: 6860.15 10:31:47 INFO - RETURN: kraken: 1525.10 10:31:47 INFO - javascript benchmark 10:31:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3164.556962025318, 3174.8888788892386, 3202.1994501374656, 3217.6138863336405, 3234.85443155058, 5196.220566914964, 5203.661761985473, 5214.243934629477, 5232.790688372465, 5306.814261500848, 5184.455632158626, 5214.878801057772, 5228.529432351088, 5255.395629502608, 5258.237555554442, 4693.976530117353, 4709.64677649176, 4756.07256584966, 4758.547937945889, 4827.131116399047, 4744.07490539345, 4749.52504749524, 4816.205326121186, 4826.396700412449, 4837.830675926343, 4763.571278584926, 4808.0, 4844.975775121137, 4846.7818948147415, 4867.537583929557, 4797.208460604031, 4802.735849528274, 4826.61387089032, 4851.975740121276, 4856.150173719585, 4701.247800351962, 4727.101850648366, 4782.641301902371, 4823.638227132979, 4871.488493708145, 5122.564582010534, 5148.227765835118, 5175.689458632494, 5194.039102766001, 5198.376194856603, 5660.971695141498, 5685.289338832646, 5685.630364446928, 5686.545076393879, 5691.402402747734, 5611.158326251054, 5613.326400831886, 5671.716414179275, 5684.261046063985, 5770.913436298459, 5224.294720212761, 5246.055709972204, 5248.685078895202, 5265.052290587692, 5283.682979021271, 5667.716614169275, 5667.914981275284, 5667.943320566824, 5689.061304884648, 5720.570957178228, 5366.812161574326, 5473.534749546333, 5503.091989821714, 5575.163725441216, 5603.215549823028, 5530.087535556669, 5551.417101204315, 5570.2480165177185, 5573.916391254134, 5574.554035677136, 5488.231647569343, 5552.7223638817895, 5567.109262517978, 5586.050371436865, 5623.915641265385, 5479.726013699299, 5562.833115006556, 5578.41426650204, 5599.0, 5645.802396916089, 4326.2212801696, 4343.2399330117105, 4343.326784348431, 4346.630536404377, 4378.299472084451, 3881.1073453105378, 3894.863679771251, 3907.5897030811925, 3921.450996860442, 3952.5256969163884, 5251.501107394792, 5253.106971814801, 5357.35711714589, 5385.165299378603, 5425.83722488326, 5607.43925607436, 5628.577856660767, 5637.816058627652, 5658.094704847204, 5684.062129748628, 5353.143497040455, 5401.108817045144, 5409.56723462122, 5420.593455490854, 5470.097433923438, 4736.95263047372, 4770.522947705202, 4798.592119669867, 4809.374781278411, 4842.612590992712, 5752.137179423036, 5767.5674324425, 5779.595428320062, 5780.913286300709, 5791.189233507313, 5438.320209973754, 5536.031194541019, 5541.889162216652, 5545.916811247754, 5595.188697638901, 5802.622829516068, 5819.941800582109, 5843.415658434123, 5848.736806843617, 5894.0, 5428.809991650273, 5447.073997420527, 5449.591280654046, 5456.127019676833, 5465.152901300305, 5490.286262785812, 5523.779048838162, 5535.418781027934, 5536.806211782729, 5545.889082218414, 5433.022056029952, 5452.672839629635, 5495.477929596682, 5530.944690553043, 5571.192177134374, 5423.3491980962535, 5458.481444262948, 5463.672179669233, 5465.426130256265, 5466.262054622575, 5341.198820176849, 5344.305240318734, 5351.063563876384, 5356.0, 5439.184122381516, 5464.235007099089, 5465.7813687453645, 5473.589480789036, 5502.8349149525575, 5521.033819081725, 5299.072662284162, 5347.1979203119845, 5359.035373632783, 5395.81114660985, 5414.945850541444], "unit": "score", "name": "dojo.html", "value": 5178.116061994893}, {"lowerIsBetter": false, "replicates": [506.9442361340252, 524.7035424984886, 538.9164679474682, 558.1376772885892, 561.5058748301494, 35870.46194307084, 36509.0, 36531.086722831875, 36670.0, 36700.44949325762, 39449.80275098621, 40257.0, 40361.19277614453, 40393.39409908854, 40432.0, 8400.075991640915, 8602.483850968962, 8615.612297446598, 8618.827623447527, 8641.567921603926, 8506.702265420712, 8626.137386261355, 8638.136186381375, 8825.95587022064, 8830.911690883073, 8755.78110547235, 8817.338699597523, 8829.337799665018, 8860.8670869937, 8894.42186257891, 8761.824763504726, 8770.6930257441, 8819.911800881973, 8856.645734170625, 8870.201681848665, 8666.956665216696, 8721.084286149926, 8725.607347669371, 8807.559622018873, 8823.338249631302, 40191.0, 40446.59553404458, 40453.59546404528, 40794.38808417876, 40908.795456022825, 2865.799394042418, 3306.5205545195813, 3312.840505822967, 3431.6225215226304, 3529.3823580873245, 28152.0, 28999.275018124717, 29034.854825725946, 29198.270043248875, 29393.412131757457, 3713.051545774697, 3751.549814022335, 3796.430535419709, 3816.8664096756756, 3855.1133239354826, 239187.0, 239307.0, 239442.6055739438, 240145.0, 241261.0, 41890.37164442536, 42199.0, 42324.730258092306, 42708.78645606752, 56167.15749263764, 41188.0, 41194.1761164775, 41419.1716165681, 41449.378259326135, 41452.79273603673, 15177.696446071017, 15427.151506667016, 15447.691046179238, 15457.768133478006, 15517.224138793015, 12365.443555040045, 12430.627081187398, 12478.5008599655, 12483.93758031204, 12611.873881261254, 14467.565973020826, 14585.927070364793, 14608.269586520631, 14624.780628290584, 14665.340059697339, 5735.655860648374, 5795.217645617788, 5824.271966004249, 5843.444872737083, 5907.409259074144, 951.1914872358578, 1014.2443879309961, 1036.2849633752687, 1042.718466014172, 1076.2520048566328, 29000.7099928998, 29092.55007364137, 29485.410291794044, 29813.40373192524, 29816.40367192644, 1044.4777611194402, 1062.208654552348, 1069.096613361708, 1093.8796732359433, 1208.6434501821984, 14929.626759331104, 15244.0, 15317.157556334285, 15571.0, 15591.766123508156, 321354.0, 466846.0, 470133.0, 472256.0, 475764.0, 55811.0, 57223.71388143116, 57381.0, 57382.85234295291, 57475.71262143662, 1373.6703191234233, 1383.0, 1391.0401822742479, 1406.7045920356636, 1506.021086293896, 29819.701802981694, 30946.381072377975, 30992.690073099882, 31315.686843131276, 31623.683763162073, 46650.0, 47288.763556182, 47331.526684732715, 47387.52612473831, 47543.286850696575, 290423.0, 296673.1996080242, 297798.0, 297854.0, 298350.0, 31966.200844979063, 32150.35699286048, 32205.0, 32309.676903230666, 32572.022839314857, 42352.78823605862, 42403.93990150271, 43178.568214317456, 43653.56346436495, 43710.56289437192, 35864.28271434609, 36763.08092297714, 36931.26137477289, 37019.814900925325, 37647.623523764414, 35971.28057438889, 36376.454353185254, 36515.63484365122, 37011.62988370082, 37120.07199820026, 36453.63546364608, 36509.26981460303, 38557.807210963765, 39107.41338879976, 39419.2116157681, 29039.0, 30496.695033050273, 30904.690953090183, 31924.962311432217, 33164.66835331712, 25453.3636659085, 25460.490790184464, 25480.362990925376, 25564.616530751682, 25598.488030238917], "unit": "score", "name": "ext.html", "value": 18099.02115542584}, {"lowerIsBetter": false, "replicates": [341.2645748412172, 352.75836052304163, 354.3816041008441, 360.83221302094523, 364.3369068295701, 16624.750628740563, 16631.41790037349, 17163.485095447155, 17180.055096969678, 17226.138693065328, 15853.445129420472, 16139.354425822983, 16560.171991400413, 16565.0, 16578.75131873023, 5196.766145523451, 5281.735913204344, 5426.9185962210595, 5532.225488431623, 5532.446755324476, 5389.299391079154, 5391.245225668409, 5447.509724124848, 5471.261379713727, 5491.341039075317, 5115.181570948649, 5321.600879934021, 5409.702466364349, 5412.702301373423, 5429.728513574325, 5265.7893684252585, 5300.390455097675, 5303.840884773444, 5304.814331498398, 5314.388845282765, 5076.771545280434, 5295.391030031518, 5442.945570544283, 5471.23402723619, 5476.151196564539, 12082.577109801116, 12354.196977196543, 12359.505619775287, 14227.64430889236, 20390.28633997803, 2163.707899433572, 2189.0587047569697, 2330.6270996640455, 2348.612478940973, 2754.862256887148, 12069.0, 12378.504859805596, 12410.317432541207, 12526.123171378007, 13139.34303284832, 1826.1964735516462, 1872.81271872813, 1883.274939148424, 1911.2928216559962, 1938.1569017477443, 68199.65900170516, 69654.3034569653, 69732.3026769731, 70220.99999999949, 71508.0, 9826.950865245628, 9920.255980801468, 9988.450635214987, 10018.699439016842, 10171.4914254287, 12994.220346779224, 13011.674708132372, 13100.344982751016, 13125.0, 13176.209427434385, 7470.850582988419, 7503.324700776956, 7584.696612135453, 7659.425543084291, 7696.538207707556, 7305.415566754753, 7332.486725929134, 7350.816229594303, 7372.668229929559, 7403.0, 3925.4896863407575, 4063.4108054331955, 4356.346548017823, 4484.0, 4591.563801438858, 1846.6399052184695, 1869.3270422647836, 1869.8597605179666, 1887.6885313923324, 1906.9427917162507, 892.1569117184199, 927.7495076329353, 932.5337331334333, 964.6671898195111, 999.4952548962727, 14967.0, 16162.979627546556, 16582.50252492427, 16748.078855663054, 17047.31810727557, 929.149827907457, 954.8949615542285, 967.908048735369, 985.6648739428629, 986.9901300986899, 9463.952680236554, 9560.426374417557, 9613.0, 9631.133198012212, 9798.706038818847, 442959.0, 458401.0, 458571.0, 466242.0, 468552.0, 73747.0, 74711.25288747043, 75171.24828751752, 76723.61638191773, 77389.6130519355, 992.0, 995.5619527407918, 1005.0452070533023, 1005.3063386263455, 1027.2295778166226, 14759.0, 14907.701845963236, 15088.849111509184, 15137.394504220149, 15245.542633721006, 32389.35221295608, 33082.83458582692, 33272.83363583167, 33432.665673342955, 33690.32619347648, 46205.76897115627, 46876.29685554787, 47273.0, 47836.760816195696, 48402.06391744431, 7435.293647103516, 7470.738524151629, 7551.395888329031, 7587.279208475186, 7664.080310362792, 11638.592649257236, 12038.398080095785, 12045.819312710491, 12426.0, 12538.247705137721, 10488.26582139243, 10580.629677961235, 10646.20153488507, 10985.285956412808, 11058.834117488404, 10520.631777887736, 10536.525856336637, 10695.572177112828, 10986.560537578407, 10997.560097596326, 10851.131909447384, 10922.781544369227, 11219.60731374398, 11226.0, 11256.986871181633, 7377.225391334047, 7397.075365579302, 7588.81027974305, 7680.308772210527, 8015.879761803694, 10029.498525073863, 10794.946025269823, 10871.40207288575, 11287.097032237565, 11325.263857849213], "unit": "score", "name": "jquery.html", "value": 8365.827752808751}, {"lowerIsBetter": false, "replicates": [1482.1996122094067, 1497.4234919555968, 1671.7158083125867, 1784.4111443223737, 1804.5097765084174, 6666.933330666692, 7299.89050164248, 7318.926810731891, 7486.887696684554, 7510.62446877656, 7347.118345798498, 7376.483646144772, 7417.703291868319, 7445.8883116753295, 7475.2151024142495, 2167.0248388225323, 2183.170395249803, 2196.0117946923947, 2198.582269368823, 2204.8677079375207, 2132.349633361824, 2147.7744836792144, 2196.6375548034557, 2206.8124209442217, 2211.7235345581803, 2180.7928246816527, 2189.813865821407, 2190.7809219078126, 2200.99854566172, 2229.57638048771, 2169.2841362350464, 2173.402314363547, 2174.0977494339986, 2179.019441251435, 2180.8255339572875, 2149.505613708856, 2181.083944743196, 2186.0709198590534, 2187.0377034104945, 2194.9341519754435, 7550.848983020363, 7559.0, 7563.130240022358, 7566.356859666935, 7569.318761311453, 4425.645948324126, 4461.397711308997, 4461.776911154429, 4502.8874278142985, 4521.412216411845, 2850.9287267818263, 2890.7398334150025, 2912.810667306618, 2914.0674984005127, 2945.3078526546246, 937.5874615169304, 978.1196922769493, 984.5028260728358, 1004.1213937804421, 1009.7223263602494, 9966.9501652492, 10006.149477294439, 10033.799324013478, 10040.29717919746, 10040.89959100407, 4055.533613634411, 4110.835566577303, 4148.979255103765, 4178.415021896937, 4179.477565304337, 8733.34499912509, 8743.169398907094, 8752.781180470412, 8768.912310876809, 8772.34207434445, 4537.500874903758, 4565.703229290086, 4586.082783443325, 4586.266197408466, 4592.402987611589, 3684.2263124743567, 4068.2066996935905, 4094.0788322627172, 4153.397757325231, 4211.663066954637, 3476.66971637694, 3496.3531746626445, 3526.8589256429455, 3541.8229088545468, 3557.3418917500344, 1067.9359238445563, 1131.6491887514733, 1144.2791041643877, 1144.948477318506, 1156.3582211872324, 1332.5136325241217, 1334.846492653338, 1348.7100273441258, 1365.9823431543366, 1368.50733735855, 6996.160460744743, 7043.471739619549, 7142.607156606333, 7217.386522145676, 7229.674664640103, 1128.960486382989, 1132.773445310941, 1143.4168574027306, 1162.7325715085408, 1166.4692564882957, 5611.6352437091455, 5618.129189975561, 5621.325440947113, 5634.126710359901, 5637.915431268452, 8592.785180370416, 8724.34567407447, 9035.45787252767, 9138.451692898447, 9142.680006199884, 8946.060663630355, 8986.19124278818, 9041.05068967762, 9056.0, 9085.227755640712, 7019.122609673791, 7090.149182098181, 7095.773555641738, 7123.394511466583, 7153.642317884189, 6829.897551536632, 6846.246912839484, 6862.588244705334, 6866.141732283465, 6873.037774711444, 7848.882266765889, 8041.718539851077, 8098.3926205536, 8109.675612975651, 8131.7560473185895, 8199.385046121684, 8382.413231073766, 8413.789655258668, 8485.915140848512, 8493.193146651058, 6278.121063051085, 6369.681515924278, 6441.420272175339, 6602.514434252447, 6638.17022872141, 7148.142222933281, 7164.068671072727, 7168.354848063699, 7174.2108368078425, 7239.058922340062, 6279.183706118175, 6293.244810622571, 6358.650274234961, 6510.414062734377, 6590.736370545316, 6337.366263373626, 6377.74489020434, 6414.166158399378, 6437.7124575084235, 6571.835704107436, 6613.305602911817, 6646.60120392778, 6649.102371179829, 6680.866382672417, 6693.062971183941, 6330.303666596578, 6366.267879193767, 6374.394432528902, 6414.903776443264, 6441.710123044568, 6255.468285195628, 6272.059191121369, 6278.246610406781, 6279.654618995999, 6288.622682639057], "unit": "score", "name": "mootools.html", "value": 4348.050873490367}, {"lowerIsBetter": false, "replicates": [330.32778296167305, 331.7545016687651, 334.4097667616657, 336.2501621384313, 340.83810190159676, 6176.752929882805, 6248.09402636618, 6294.842628934279, 6298.811035668931, 6347.61914285142, 6121.663308518041, 6144.631322120676, 6188.071789231618, 6199.845003874905, 6207.224096987877, 4543.295789152687, 4627.259638457847, 4655.068986202756, 4664.043871006453, 4771.093492236472, 4563.589276965073, 4637.675362724611, 4648.256278995362, 4651.44182698075, 4652.837150699726, 4561.429821272341, 4569.657275704319, 4601.700889442175, 4610.331501932218, 4618.653600979923, 4573.656975726817, 4610.631149508032, 4614.676972611918, 4639.582437580634, 4645.396098507173, 3972.0, 3985.4818873546255, 3989.7606143631183, 4005.0387906902424, 4006.979965100156, 5832.562557808139, 5883.17635531026, 5922.200502932092, 5938.138969849348, 5938.970305148489, 5210.609204309654, 5375.274337964363, 5402.405735369106, 5415.10650742627, 5415.891682166334, 6462.806115816533, 6518.739250429977, 6522.543421960465, 6524.347565243485, 6543.312952140052, 4439.0, 4445.288753799409, 4448.866534003952, 4457.153140903218, 4462.3752674625575, 6777.830554236134, 6817.5568588042115, 6852.5203235773515, 6856.862862742717, 6858.142732158481, 4528.049109687003, 4539.909201815945, 4540.568645978627, 4559.612432943237, 4573.47405048417, 4379.802908869108, 4471.888202794956, 4477.0, 4481.731096134243, 4627.884302892455, 5274.736263186825, 5275.419703832576, 5279.947200528022, 5318.0, 5323.6273460857365, 6430.678466076677, 6546.0835483032415, 6568.540202185801, 6585.86828263432, 6592.868142637216, 1615.7414813629998, 1635.4766474727974, 1639.418006607661, 1640.4750479846573, 1643.2276829889934, 1065.6057258814287, 1081.351189286422, 1090.7545802194443, 1104.7127746785893, 1107.9889201108047, 6279.811605651837, 6312.147860038928, 6322.873542529215, 6330.303666596671, 6334.904976425358, 6744.0895479109695, 6753.594784312957, 6756.932430675729, 6760.797176084725, 6778.864422711518, 6223.066540019034, 6269.529785266123, 6322.430981211621, 6376.776812811529, 6402.551821372553, 3686.705063594906, 3703.3148867459604, 3706.4625629283605, 3707.1288247261873, 3707.610700876423, 7254.709811607477, 7272.709091636381, 7282.817929551804, 7284.38082762971, 7311.451641126937, 6989.790306290819, 7006.264342244093, 7023.508354415142, 7039.894401583981, 7043.8239044023285, 7068.0, 7142.142942846787, 7239.457040721862, 7246.60143692102, 7287.70849166038, 6767.424768894502, 6799.830004249933, 6805.183377994672, 6812.591244525344, 6826.317368263134, 6713.227978782503, 6735.090762746966, 6738.66306684654, 6745.2242992056545, 6772.729090836311, 7221.386182174574, 7225.0, 7228.277172282729, 7240.710371585077, 7253.56478611285, 4423.756693381895, 4488.865334039984, 4523.0, 4540.977295113504, 4541.0, 6812.4890633203695, 6846.315368463114, 6858.5199036067, 6871.9656401717675, 6892.0, 6590.0, 6616.603003819786, 6623.304553021863, 6625.867482650224, 6637.502187335873, 6623.304553021863, 6624.668766561749, 6630.569013014331, 6633.668316584248, 6638.402543771083, 6330.177076980147, 6470.38531339522, 6489.707963141575, 6518.608883467007, 6518.706658200487, 6612.371824676648, 6619.635920024445, 6623.768168114093, 6653.567518111307, 6666.899996500153, 6444.645544494911, 6456.257530384066, 6481.513886458629, 6483.157189565326, 6504.1869766279215], "unit": "score", "name": "prototype.html", "value": 4927.377020019033}, {"lowerIsBetter": false, "replicates": [679.4971720926515, 687.4225650453618, 754.4002517998191, 788.5229436191108, 794.3565711773467, 13592.116512426684, 13781.72436551271, 13789.655258618539, 13883.375248113834, 13927.234002129879, 12099.697507562316, 12933.288669123194, 13125.278109703962, 13189.208647481159, 13195.538156164535, 826.5454000299826, 835.7075023741672, 844.1853611265128, 844.6536919862857, 845.5772113943028, 830.8462934357133, 833.2584000239791, 834.8038211020405, 836.0469065265572, 838.1409055717877, 871.4422769427572, 874.396666300254, 878.7319867440428, 879.5821984557348, 880.3529405886668, 870.2254993056185, 872.8036191856845, 874.0254616103063, 875.6322344615213, 877.7893305606673, 645.8579112595221, 648.944839688627, 651.6253154436218, 652.8726898254843, 653.2781276689237, 12542.623721288375, 12609.0, 12654.620361389174, 12662.0, 12706.936465317707, 11421.942890285578, 11423.0, 11539.134564907665, 11595.884041159565, 11671.562122590212, 9391.436513809125, 9403.952980235055, 9521.095495927944, 9685.70942871715, 9812.313138080337, 3476.7566270361085, 3526.1713497328105, 3541.663541963535, 3604.8197590120653, 3606.206634540397, 49639.50360496385, 49742.7512862437, 49785.75107124441, 49795.25307120396, 49895.25157122646, 8091.352691784643, 8377.287930525852, 10022.849657255147, 10155.187584993182, 10575.101116405192, 18256.63486730258, 18368.724469132972, 18371.448856534324, 18399.632007360047, 18410.63178736418, 7928.6035698214855, 7931.0, 8017.438779285394, 8041.356691464669, 8309.210624990616, 4541.159885421208, 4612.377329060601, 4632.073585282957, 4671.205894997858, 4675.812967481263, 3177.539256807796, 3209.1335339458215, 3221.710046095816, 3222.4844024955896, 3224.967750322514, 561.7921369093461, 563.6477201748907, 566.9092945128759, 569.0780934885512, 583.4369833111068, 616.6022915219659, 631.8799428108645, 642.4321492814651, 644.4683136412385, 652.9510286728514, 7982.760517184378, 8156.1028286888395, 8241.752747417588, 8326.70856520019, 8521.701740439055, 537.0199386120346, 592.6207227374484, 601.0653433910311, 612.2805703298607, 660.3495556876472, 3854.1328201155075, 3890.183061557048, 3954.228925359585, 3988.7008474363956, 4001.7198796083994, 58067.0, 59317.70341148267, 59418.702906486054, 59676.0, 60055.39944600585, 43592.56407435885, 50864.23703644448, 51470.742646287275, 52603.73698131485, 52648.73675631597, 44161.33757993633, 44234.77882610566, 45980.0, 46030.76984615123, 46258.537414625425, 8271.379646526415, 8313.501189928624, 8415.789605259917, 8616.43993140469, 8644.827103458021, 35010.64989350074, 35070.649293506736, 36128.27743445064, 36614.63385366112, 36790.63209367872, 40237.19525609413, 43842.56157438512, 45274.54725452703, 45661.77169114133, 46127.53872461367, 9622.0, 9719.611215551298, 10309.639162629272, 10463.267571269938, 10473.21450891171, 11527.308361498337, 11823.586174483851, 11966.162368634112, 12194.634160975185, 12364.134510584172, 10243.887883188696, 10419.843702344318, 10534.262601617813, 10563.366198028143, 10946.288491248044, 10529.42088185157, 10809.945950270197, 10856.0, 10917.072048875934, 11279.266847654877, 10278.948605256926, 10348.22388320894, 10422.166226701996, 10784.029437350677, 10785.0, 9005.729828105168, 9192.49441280736, 9262.907370926205, 9468.431894086378, 9638.277129215197, 7761.051753584719, 8085.231902969209, 8321.54231517248, 8681.696140635047, 8711.825763484821], "unit": "score", "name": "yui.html", "value": 6204.6392621226005}], "name": "dromaeo_css", "value": 6860.147387394585}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 105.0, 111.0, 111.0, 110.0, 121.0, 113.0, 110.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.2}, {"lowerIsBetter": true, "replicates": [155.0, 136.0, 160.0, 168.0, 130.0, 167.0, 158.0, 131.0, 169.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 150.4}, {"lowerIsBetter": true, "replicates": [163.0, 163.0, 163.0, 162.0, 165.0, 163.0, 163.0, 167.0, 168.0, 162.0], "unit": "score", "name": "audio-dft", "value": 163.9}, {"lowerIsBetter": true, "replicates": [77.0, 75.0, 76.0, 76.0, 75.0, 76.0, 73.0, 144.0, 74.0, 75.0], "unit": "score", "name": "audio-fft", "value": 82.1}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 142.0, 93.0, 94.0, 93.0, 144.0, 94.0, 93.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 108.3}, {"lowerIsBetter": true, "replicates": [117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 117.0, 117.0, 117.0, 118.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.5}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 148.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.3}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 97.0, 96.0, 96.0, 95.0, 96.0, 97.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [58.0, 56.0, 57.0, 60.0, 56.0, 57.0, 56.0, 56.0, 57.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.6}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 67.0, 67.0, 67.0, 67.0, 68.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.2}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 84.0, 84.0, 82.0, 82.0, 91.0, 83.0, 84.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.1}, {"lowerIsBetter": true, "replicates": [116.0, 127.0, 118.0, 117.0, 123.0, 118.0, 130.0, 124.0, 117.0, 125.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.5}, {"lowerIsBetter": true, "replicates": [148.0, 151.0, 152.0, 152.0, 152.0, 140.0, 151.0, 162.0, 150.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.9}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 74.0, 68.0, 72.0, 68.0, 69.0, 68.0, 71.0, 73.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.0}], "name": "kraken", "value": 1525.1000000000001}]} 10:31:47 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1525.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6860.15"}}} 10:31:47 INFO - Return code: 0 10:31:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 10:31:47 ERROR - # TBPL SUCCESS # 10:31:47 INFO - Running post-action listener: _resource_record_post_action 10:31:47 INFO - Running post-run listener: _resource_record_post_run 10:31:48 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 533282816; Read time: 12; Write time: 760992 10:31:48 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 0; Write bytes: 240709632; Read time: 0; Write time: 473604 10:31:48 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292421632; Read time: 12; Write time: 287204 10:31:48 INFO - Running post-run listener: _upload_blobber_files 10:31:48 INFO - Blob upload gear active. 10:31:48 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 10:31:48 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 10:31:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 10:31:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 10:31:48 INFO - (blobuploader) - INFO - Open directory for files ... 10:31:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:31:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:31:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:31:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:31:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:31:49 INFO - (blobuploader) - INFO - Done attempting. 10:31:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:31:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:31:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:31:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:31:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:31:50 INFO - (blobuploader) - INFO - Done attempting. 10:31:50 INFO - (blobuploader) - INFO - Iteration through files over. 10:31:50 INFO - Return code: 0 10:31:50 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 10:31:50 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 10:31:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/50402a53d9253555fdbf68628f26128fc4b6fae58f329d535bab3129c43869e00a8efb9b788db7b046f611ffb97bfacf10e5b05a604ad17ae7a94cff1db4b172", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e58ba4c99b439c84dc115e7e94213273d659f367be99cd467411602a584a33f721edb53ce0257ea31fb940d505db2824b093eb84a3eda93255fbdc7aaf315b04"} 10:31:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 10:31:50 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 10:31:50 INFO - Contents: 10:31:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/50402a53d9253555fdbf68628f26128fc4b6fae58f329d535bab3129c43869e00a8efb9b788db7b046f611ffb97bfacf10e5b05a604ad17ae7a94cff1db4b172", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e58ba4c99b439c84dc115e7e94213273d659f367be99cd467411602a584a33f721edb53ce0257ea31fb940d505db2824b093eb84a3eda93255fbdc7aaf315b04"} 10:31:50 INFO - Running post-run listener: copy_logs_to_upload_dir 10:31:50 INFO - Copying logs to upload dir... 10:31:50 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 10:31:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.547439 ========= master_lag: 10.38 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-03-02 10:32:00.336291) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-02 10:32:00.340040) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1456941755.609493-1377747993 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/50402a53d9253555fdbf68628f26128fc4b6fae58f329d535bab3129c43869e00a8efb9b788db7b046f611ffb97bfacf10e5b05a604ad17ae7a94cff1db4b172", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e58ba4c99b439c84dc115e7e94213273d659f367be99cd467411602a584a33f721edb53ce0257ea31fb940d505db2824b093eb84a3eda93255fbdc7aaf315b04"} build_url:https://queue.taskcluster.net/v1/task/JORtoHwzRSamQmNe0h7r-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011349 build_url: 'https://queue.taskcluster.net/v1/task/JORtoHwzRSamQmNe0h7r-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/50402a53d9253555fdbf68628f26128fc4b6fae58f329d535bab3129c43869e00a8efb9b788db7b046f611ffb97bfacf10e5b05a604ad17ae7a94cff1db4b172", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e58ba4c99b439c84dc115e7e94213273d659f367be99cd467411602a584a33f721edb53ce0257ea31fb940d505db2824b093eb84a3eda93255fbdc7aaf315b04"}' ========= master_lag: 0.16 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-02 10:32:00.516230) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 10:32:00.516518) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1456941755.609493-1377747993 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004567 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 10:32:00.532446) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-02 10:32:00.532859) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-02 10:32:00.533114) ========= ========= Total master_lag: 10.97 =========