builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-009 starttime: 1457432640.86 results: success (0) buildid: 20160307110832 builduid: b0fbdd96eb50429c953c1789946b3361 revision: a06ac8e3220a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-08 02:24:00.864154) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-08 02:24:00.864575) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-08 02:24:00.864873) ========= 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=aa52b8aba932b19cc50b5275000001de-1457432638.584047-1465674945 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004301 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-08 02:24:00.883054) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-08 02:24:00.883383) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-08 02:24:01.540955) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 02:24:01.541217) ========= 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=aa52b8aba932b19cc50b5275000001de-1457432638.584047-1465674945 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004585 ========= master_lag: 0.14 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 02:24:01.686797) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-08 02:24:01.687412) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-08 02:24:01.688124) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 02:24:01.691738) ========= 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=aa52b8aba932b19cc50b5275000001de-1457432638.584047-1465674945 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-08 02:24:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 68.0M=0s 2016-03-08 02:24:01 (68.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104067 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 02:24:01.818078) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 02:24:01.818381) ========= 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=aa52b8aba932b19cc50b5275000001de-1457432638.584047-1465674945 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020101 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 02:24:01.874534) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 02:24:01.875072) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a06ac8e3220a --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a06ac8e3220a --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=aa52b8aba932b19cc50b5275000001de-1457432638.584047-1465674945 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-08 02:24:01,970 Setting DEBUG logging. 2016-03-08 02:24:01,970 attempt 1/10 2016-03-08 02:24:01,970 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a06ac8e3220a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-08 02:24:02,244 unpacking tar archive at: mozilla-aurora-a06ac8e3220a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.545459 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 02:24:02.433807) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-08 02:24:02.434157) ========= echo a06ac8e3220a in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'a06ac8e3220a'] 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=aa52b8aba932b19cc50b5275000001de-1457432638.584047-1465674945 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False a06ac8e3220a program finished with exit code 0 elapsedTime=0.003468 script_repo_revision: 'a06ac8e3220a' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-08 02:24:02.480820) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-08 02:24:02.481095) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-08 02:24:02.490376) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-03-08 02:24:02.490651) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=aa52b8aba932b19cc50b5275000001de-1457432638.584047-1465674945 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:24:02 INFO - MultiFileLogger online at 20160308 02:24:02 in /builds/slave/test-pgo 02:24:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:24:02 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 02:24:02 INFO - {'append_to_log': False, 02:24:02 INFO - 'base_work_dir': '/builds/slave/test-pgo', 02:24:02 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:24:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 02:24:02 INFO - 'branch': 'Mozilla-Aurora', 02:24:02 INFO - 'buildbot_json_path': 'buildprops.json', 02:24:02 INFO - 'config_files': ('talos/linux_config.py',), 02:24:02 INFO - 'default_actions': ('clobber', 02:24:02 INFO - 'read-buildbot-config', 02:24:02 INFO - 'download-and-extract', 02:24:02 INFO - 'populate-webroot', 02:24:02 INFO - 'create-virtualenv', 02:24:02 INFO - 'install', 02:24:02 INFO - 'run-tests'), 02:24:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:24:02 INFO - 'download_minidump_stackwalk': True, 02:24:02 INFO - 'download_symbols': 'ondemand', 02:24:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:24:02 INFO - 'tooltool.py': '/tools/tooltool.py', 02:24:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:24:02 INFO - '/tools/misc-python/virtualenv.py')}, 02:24:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:24:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:24:02 INFO - 'installer_path': 'installer.exe', 02:24:02 INFO - 'log_level': 'info', 02:24:02 INFO - 'log_name': 'talos', 02:24:02 INFO - 'log_to_console': True, 02:24:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:24:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:24:02 INFO - 'opt_config_files': (), 02:24:02 INFO - 'pip_index': False, 02:24:02 INFO - 'sps_profile': False, 02:24:02 INFO - 'sps_profile_interval': 0, 02:24:02 INFO - 'suite': 'dromaeojs', 02:24:02 INFO - 'system_bits': '32', 02:24:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:24:02 INFO - 'title': 'talos-linux64-ix-009', 02:24:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:24:02 INFO - 'use_talos_json': True, 02:24:02 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 02:24:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:24:02 INFO - 'work_dir': 'build'} 02:24:02 INFO - ##### 02:24:02 INFO - ##### Running clobber step. 02:24:02 INFO - ##### 02:24:02 INFO - Running pre-action listener: _resource_record_pre_action 02:24:02 INFO - Running main action method: clobber 02:24:02 INFO - rmtree: /builds/slave/test-pgo/build 02:24:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 02:24:03 INFO - Running post-action listener: _resource_record_post_action 02:24:03 INFO - ##### 02:24:03 INFO - ##### Running read-buildbot-config step. 02:24:03 INFO - ##### 02:24:03 INFO - Running pre-action listener: _resource_record_pre_action 02:24:03 INFO - Running main action method: read_buildbot_config 02:24:03 INFO - Using buildbot properties: 02:24:03 INFO - { 02:24:03 INFO - "project": "", 02:24:03 INFO - "product": "firefox", 02:24:03 INFO - "script_repo_revision": "production", 02:24:03 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 02:24:03 INFO - "repository": "", 02:24:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 02:24:03 INFO - "buildid": "20160307110832", 02:24:03 INFO - "pgo_build": "True", 02:24:03 INFO - "basedir": "/builds/slave/test-pgo", 02:24:03 INFO - "buildnumber": 338, 02:24:03 INFO - "slavename": "talos-linux64-ix-009", 02:24:03 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:24:03 INFO - "platform": "ubuntu64_hw", 02:24:03 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 02:24:03 INFO - "branch": "mozilla-aurora", 02:24:03 INFO - "repo_path": "releases/mozilla-aurora", 02:24:03 INFO - "revision": "a06ac8e3220a", 02:24:03 INFO - "stage_platform": "linux64-pgo", 02:24:03 INFO - "builduid": "b0fbdd96eb50429c953c1789946b3361", 02:24:03 INFO - "slavebuilddir": "test" 02:24:03 INFO - } 02:24:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/DXC_oMDVQqezRTaaZpA3IQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 02:24:03 INFO - Running post-action listener: _resource_record_post_action 02:24:03 INFO - ##### 02:24:03 INFO - ##### Running download-and-extract step. 02:24:03 INFO - ##### 02:24:03 INFO - Running pre-action listener: _resource_record_pre_action 02:24:03 INFO - Running main action method: download_and_extract 02:24:03 INFO - mkdir: /builds/slave/test-pgo/build/tests 02:24:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:03 INFO - https://queue.taskcluster.net/v1/task/DXC_oMDVQqezRTaaZpA3IQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:24:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXC_oMDVQqezRTaaZpA3IQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 02:24:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXC_oMDVQqezRTaaZpA3IQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 02:24:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXC_oMDVQqezRTaaZpA3IQ/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 02:24:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXC_oMDVQqezRTaaZpA3IQ/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 02:24:04 INFO - Downloaded 1448 bytes. 02:24:04 INFO - Reading from file /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 02:24:04 INFO - Using the following test package requirements: 02:24:04 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 02:24:04 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 02:24:04 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:24:04 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 02:24:04 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:24:04 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 02:24:04 INFO - u'jsshell-linux-x86_64.zip'], 02:24:04 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 02:24:04 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:24:04 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 02:24:04 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 02:24:04 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:24:04 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 02:24:04 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:24:04 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 02:24:04 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:24:04 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 02:24:04 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 02:24:04 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:24:04 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:24:04 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')]} 02:24:04 INFO - https://queue.taskcluster.net/v1/task/DXC_oMDVQqezRTaaZpA3IQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:24:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXC_oMDVQqezRTaaZpA3IQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 02:24:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXC_oMDVQqezRTaaZpA3IQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 02:24:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXC_oMDVQqezRTaaZpA3IQ/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 02:24:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXC_oMDVQqezRTaaZpA3IQ/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 02:24:12 INFO - Downloaded 23397998 bytes. 02:24:12 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'] 02:24:12 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 02:24:14 INFO - Return code: 0 02:24:14 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 02:24:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:14 INFO - https://queue.taskcluster.net/v1/task/DXC_oMDVQqezRTaaZpA3IQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:24:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXC_oMDVQqezRTaaZpA3IQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 02:24:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXC_oMDVQqezRTaaZpA3IQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 02:24:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXC_oMDVQqezRTaaZpA3IQ/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 02:24:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXC_oMDVQqezRTaaZpA3IQ/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 02:24:16 INFO - Downloaded 23397998 bytes. 02:24:16 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'] 02:24:16 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 02:24:18 INFO - Return code: 0 02:24:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:18 INFO - https://queue.taskcluster.net/v1/task/DXC_oMDVQqezRTaaZpA3IQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:24:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXC_oMDVQqezRTaaZpA3IQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 02:24:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXC_oMDVQqezRTaaZpA3IQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 02:24:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXC_oMDVQqezRTaaZpA3IQ/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 02:24:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXC_oMDVQqezRTaaZpA3IQ/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 02:24:18 INFO - Downloaded 10803659 bytes. 02:24:18 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'] 02:24:18 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 02:24:19 INFO - Return code: 0 02:24:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:19 INFO - https://queue.taskcluster.net/v1/task/DXC_oMDVQqezRTaaZpA3IQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:24:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXC_oMDVQqezRTaaZpA3IQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 02:24:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXC_oMDVQqezRTaaZpA3IQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 02:24:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXC_oMDVQqezRTaaZpA3IQ/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 02:24:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXC_oMDVQqezRTaaZpA3IQ/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 02:24:20 INFO - Downloaded 56123602 bytes. 02:24:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DXC_oMDVQqezRTaaZpA3IQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 02:24:20 INFO - mkdir: /builds/slave/test-pgo/properties 02:24:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 02:24:20 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 02:24:20 INFO - Contents: 02:24:20 INFO - build_url:https://queue.taskcluster.net/v1/task/DXC_oMDVQqezRTaaZpA3IQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 02:24:21 INFO - Running post-action listener: _resource_record_post_action 02:24:21 INFO - Running post-action listener: set_extra_try_arguments 02:24:21 INFO - ##### 02:24:21 INFO - ##### Running populate-webroot step. 02:24:21 INFO - ##### 02:24:21 INFO - Running pre-action listener: _resource_record_pre_action 02:24:21 INFO - Running main action method: populate_webroot 02:24:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:24:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:24:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:24:21 INFO - '--tppagecycles', 02:24:21 INFO - '7'], 02:24:21 INFO - 'tests': ['tsvgm']}}, 02:24:21 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:24:21 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:24:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:24:21 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 02:24:21 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:24:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:24:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:24:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:24:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:24:21 INFO - 'talos_options': ['--e10s'], 02:24:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:24:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:24:21 INFO - 'tests': ['damp', 'tps']}, 02:24:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:24:21 INFO - 'talos_options': ['--e10s'], 02:24:21 INFO - 'tests': ['damp', 'tps']}, 02:24:21 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:24:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:24:21 INFO - 'other': {'tests': ['a11yr', 02:24:21 INFO - 'ts_paint', 02:24:21 INFO - 'tpaint', 02:24:21 INFO - 'sessionrestore', 02:24:21 INFO - 'sessionrestore_no_auto_restore']}, 02:24:21 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:24:21 INFO - 'tests': ['a11yr', 02:24:21 INFO - 'ts_paint', 02:24:21 INFO - 'tpaint', 02:24:21 INFO - 'sessionrestore', 02:24:21 INFO - 'sessionrestore_no_auto_restore']}, 02:24:21 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:24:21 INFO - 'tests': ['a11yr', 02:24:21 INFO - 'ts_paint', 02:24:21 INFO - 'tpaint', 02:24:21 INFO - 'sessionrestore', 02:24:21 INFO - 'sessionrestore_no_auto_restore']}, 02:24:21 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:24:21 INFO - 'tests': ['a11yr', 02:24:21 INFO - 'ts_paint', 02:24:21 INFO - 'tpaint', 02:24:21 INFO - 'sessionrestore', 02:24:21 INFO - 'sessionrestore_no_auto_restore']}, 02:24:21 INFO - 'other_l64': {'tests': ['a11yr', 02:24:21 INFO - 'ts_paint', 02:24:21 INFO - 'tpaint', 02:24:21 INFO - 'sessionrestore', 02:24:21 INFO - 'sessionrestore_no_auto_restore']}, 02:24:21 INFO - 'other_nol64': {'tests': ['a11yr', 02:24:21 INFO - 'ts_paint', 02:24:21 INFO - 'tpaint', 02:24:21 INFO - 'sessionrestore', 02:24:21 INFO - 'sessionrestore_no_auto_restore']}, 02:24:21 INFO - 'svgr': {'tests': ['tsvgx', 02:24:21 INFO - 'tsvgr_opacity', 02:24:21 INFO - 'tart', 02:24:21 INFO - 'tscrollx', 02:24:21 INFO - 'cart']}, 02:24:21 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:24:21 INFO - 'tests': ['tsvgx', 02:24:21 INFO - 'tsvgr_opacity', 02:24:21 INFO - 'tart', 02:24:21 INFO - 'tscrollx', 02:24:21 INFO - 'cart']}, 02:24:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:24:21 INFO - 'tests': ['tp5o']}, 02:24:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:24:21 INFO - 'talos_options': ['--e10s'], 02:24:21 INFO - 'tests': ['tp5o']}, 02:24:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:24:21 INFO - 'talos_options': ['--xperf_path', 02:24:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:24:21 INFO - 'tests': ['tp5n']}, 02:24:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:24:21 INFO - 'talos_options': ['--e10s', 02:24:21 INFO - '--xperf_path', 02:24:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:24:21 INFO - 'tests': ['tp5n']}}, 02:24:21 INFO - 'talos.zip': {'path': '', 02:24:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:24:21 INFO - Running post-action listener: _resource_record_post_action 02:24:21 INFO - ##### 02:24:21 INFO - ##### Running create-virtualenv step. 02:24:21 INFO - ##### 02:24:21 INFO - Running pre-action listener: _resource_record_pre_action 02:24:21 INFO - Running main action method: create_virtualenv 02:24:21 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 02:24:21 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 02:24:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 02:24:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:24:21 INFO - Using real prefix '/usr' 02:24:21 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 02:24:21 INFO - Installing distribute.............................................................................................................................................................................................done. 02:24:23 INFO - Installing pip.................done. 02:24:23 INFO - Return code: 0 02:24:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 02:24: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')]} 02:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24: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')]} 02:24:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:23 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 0x7f41d55fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x280c6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289b920>, '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 0x289c820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289ccb0>, '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': 'aa52b8aba932b19cc50b5275000001de-1457432638.584047-1465674945', '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 02:24:23 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 02:24:23 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 02:24:23 INFO - Using env: {'DISPLAY': ':0', 02:24:23 INFO - 'HOME': '/home/cltbld', 02:24:23 INFO - 'LANG': 'en_US.UTF-8', 02:24:23 INFO - 'LANGUAGE': 'en_US:en', 02:24:23 INFO - 'LOGNAME': 'cltbld', 02:24:23 INFO - 'MAIL': '/var/mail/cltbld', 02:24:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:23 INFO - 'MOZ_NO_REMOTE': '1', 02:24:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:23 INFO - 'NO_EM_RESTART': '1', 02:24:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:24:23 INFO - 'PWD': '/builds/slave/test-pgo', 02:24:23 INFO - 'SHELL': '/bin/bash', 02:24:23 INFO - 'SHLVL': '1', 02:24:23 INFO - 'TERM': 'linux', 02:24:23 INFO - 'TMOUT': '86400', 02:24:23 INFO - 'USER': 'cltbld', 02:24:23 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1457432638.584047-1465674945', 02:24:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:23 INFO - '_': '/tools/buildbot/bin/python'} 02:24:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:23 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 02:24:23 INFO - Cleaning up... 02:24:23 INFO - Return code: 0 02:24:23 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 02:24: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')]} 02:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24: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')]} 02:24:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:23 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 0x7f41d55fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x280c6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289b920>, '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 0x289c820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289ccb0>, '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': 'aa52b8aba932b19cc50b5275000001de-1457432638.584047-1465674945', '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 02:24:23 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 02:24:23 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 02:24:23 INFO - Using env: {'DISPLAY': ':0', 02:24:23 INFO - 'HOME': '/home/cltbld', 02:24:23 INFO - 'LANG': 'en_US.UTF-8', 02:24:23 INFO - 'LANGUAGE': 'en_US:en', 02:24:23 INFO - 'LOGNAME': 'cltbld', 02:24:23 INFO - 'MAIL': '/var/mail/cltbld', 02:24:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:23 INFO - 'MOZ_NO_REMOTE': '1', 02:24:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:23 INFO - 'NO_EM_RESTART': '1', 02:24:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:24:23 INFO - 'PWD': '/builds/slave/test-pgo', 02:24:23 INFO - 'SHELL': '/bin/bash', 02:24:23 INFO - 'SHLVL': '1', 02:24:23 INFO - 'TERM': 'linux', 02:24:23 INFO - 'TMOUT': '86400', 02:24:23 INFO - 'USER': 'cltbld', 02:24:23 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1457432638.584047-1465674945', 02:24:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:23 INFO - '_': '/tools/buildbot/bin/python'} 02:24:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:24 INFO - Downloading/unpacking psutil>=0.7.1 02:24:24 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 02:24:24 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 02:24:24 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 02:24:24 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 02:24:24 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 02:24:24 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 02:24:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 02:24:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:24:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:24:26 INFO - Installing collected packages: psutil 02:24:26 INFO - Running setup.py install for psutil 02:24:26 INFO - building 'psutil._psutil_linux' extension 02:24:26 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 02:24:26 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 02:24:26 INFO - building 'psutil._psutil_posix' extension 02:24:26 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 02:24:26 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 02:24:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:24:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:24:26 INFO - Successfully installed psutil 02:24:26 INFO - Cleaning up... 02:24:26 INFO - Return code: 0 02:24:26 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 02:24: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')]} 02:24:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24: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')]} 02:24:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:26 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 0x7f41d55fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x280c6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289b920>, '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 0x289c820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289ccb0>, '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': 'aa52b8aba932b19cc50b5275000001de-1457432638.584047-1465674945', '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 02:24:26 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 02:24:26 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 02:24:26 INFO - Using env: {'DISPLAY': ':0', 02:24:26 INFO - 'HOME': '/home/cltbld', 02:24:26 INFO - 'LANG': 'en_US.UTF-8', 02:24:26 INFO - 'LANGUAGE': 'en_US:en', 02:24:26 INFO - 'LOGNAME': 'cltbld', 02:24:26 INFO - 'MAIL': '/var/mail/cltbld', 02:24:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:26 INFO - 'MOZ_NO_REMOTE': '1', 02:24:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:26 INFO - 'NO_EM_RESTART': '1', 02:24:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:24:26 INFO - 'PWD': '/builds/slave/test-pgo', 02:24:26 INFO - 'SHELL': '/bin/bash', 02:24:26 INFO - 'SHLVL': '1', 02:24:26 INFO - 'TERM': 'linux', 02:24:26 INFO - 'TMOUT': '86400', 02:24:26 INFO - 'USER': 'cltbld', 02:24:26 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1457432638.584047-1465674945', 02:24:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:26 INFO - '_': '/tools/buildbot/bin/python'} 02:24:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:26 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:24:26 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 02:24:26 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 02:24:26 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 02:24:26 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 02:24:26 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 02:24:26 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 02:24:28 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:24:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:24:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:24:28 INFO - Installing collected packages: mozsystemmonitor 02:24:28 INFO - Running setup.py install for mozsystemmonitor 02:24:28 INFO - Successfully installed mozsystemmonitor 02:24:28 INFO - Cleaning up... 02:24:28 INFO - Return code: 0 02:24:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 02:24:28 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')]} 02:24:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:28 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')]} 02:24:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:28 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 0x7f41d55fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x280c6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289b920>, '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 0x289c820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289ccb0>, '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': 'aa52b8aba932b19cc50b5275000001de-1457432638.584047-1465674945', '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 02:24:28 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 02:24:28 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 02:24:28 INFO - Using env: {'DISPLAY': ':0', 02:24:28 INFO - 'HOME': '/home/cltbld', 02:24:28 INFO - 'LANG': 'en_US.UTF-8', 02:24:28 INFO - 'LANGUAGE': 'en_US:en', 02:24:28 INFO - 'LOGNAME': 'cltbld', 02:24:28 INFO - 'MAIL': '/var/mail/cltbld', 02:24:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:28 INFO - 'MOZ_NO_REMOTE': '1', 02:24:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:28 INFO - 'NO_EM_RESTART': '1', 02:24:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:24:28 INFO - 'PWD': '/builds/slave/test-pgo', 02:24:28 INFO - 'SHELL': '/bin/bash', 02:24:28 INFO - 'SHLVL': '1', 02:24:28 INFO - 'TERM': 'linux', 02:24:28 INFO - 'TMOUT': '86400', 02:24:28 INFO - 'USER': 'cltbld', 02:24:28 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1457432638.584047-1465674945', 02:24:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:28 INFO - '_': '/tools/buildbot/bin/python'} 02:24:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:29 INFO - Downloading/unpacking blobuploader==1.2.4 02:24:29 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 02:24:29 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 02:24:29 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 02:24:29 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 02:24:29 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 02:24:29 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 02:24:30 INFO - Downloading blobuploader-1.2.4.tar.gz 02:24:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:24:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:24:31 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 02:24:31 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 02:24:31 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 02:24:31 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 02:24:31 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 02:24:31 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 02:24:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 02:24:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:24:31 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 02:24:31 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 02:24:31 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 02:24:31 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 02:24:31 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 02:24:31 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 02:24:31 INFO - Downloading docopt-0.6.1.tar.gz 02:24:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 02:24:31 INFO - Installing collected packages: blobuploader, requests, docopt 02:24:31 INFO - Running setup.py install for blobuploader 02:24:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:24:31 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 02:24:31 INFO - Running setup.py install for requests 02:24:32 INFO - Running setup.py install for docopt 02:24:32 INFO - Successfully installed blobuploader requests docopt 02:24:32 INFO - Cleaning up... 02:24:32 INFO - Return code: 0 02:24:32 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:24:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:32 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 0x7f41d55fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x280c6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289b920>, '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 0x289c820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289ccb0>, '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': 'aa52b8aba932b19cc50b5275000001de-1457432638.584047-1465674945', '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 02:24:32 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 02:24:32 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 02:24:32 INFO - Using env: {'DISPLAY': ':0', 02:24:32 INFO - 'HOME': '/home/cltbld', 02:24:32 INFO - 'LANG': 'en_US.UTF-8', 02:24:32 INFO - 'LANGUAGE': 'en_US:en', 02:24:32 INFO - 'LOGNAME': 'cltbld', 02:24:32 INFO - 'MAIL': '/var/mail/cltbld', 02:24:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:32 INFO - 'MOZ_NO_REMOTE': '1', 02:24:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:32 INFO - 'NO_EM_RESTART': '1', 02:24:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:24:32 INFO - 'PWD': '/builds/slave/test-pgo', 02:24:32 INFO - 'SHELL': '/bin/bash', 02:24:32 INFO - 'SHLVL': '1', 02:24:32 INFO - 'TERM': 'linux', 02:24:32 INFO - 'TMOUT': '86400', 02:24:32 INFO - 'USER': 'cltbld', 02:24:32 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1457432638.584047-1465674945', 02:24:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:32 INFO - '_': '/tools/buildbot/bin/python'} 02:24:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:24:32 INFO - Running setup.py (path:/tmp/pip-whJefW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:24:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:24:32 INFO - Running setup.py (path:/tmp/pip-AqtHR7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:24:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:24:32 INFO - Running setup.py (path:/tmp/pip-_D6h6N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:24:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:24:32 INFO - Running setup.py (path:/tmp/pip-0Sw32C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:24:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 02:24:32 INFO - Running setup.py (path:/tmp/pip-aiAloz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 02:24:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:24:32 INFO - Running setup.py (path:/tmp/pip-cuWKmD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:24:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:24:32 INFO - Running setup.py (path:/tmp/pip-ZdHZ03-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:24:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:24:33 INFO - Running setup.py (path:/tmp/pip-kyVQ5S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:24:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 02:24:33 INFO - Running setup.py (path:/tmp/pip-SSH3eF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 02:24:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 02:24:33 INFO - Running setup.py (path:/tmp/pip-13kD1_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 02:24:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:24:33 INFO - Running setup.py (path:/tmp/pip-4mh2gI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:24:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:24:33 INFO - Running setup.py (path:/tmp/pip-Cz7U5r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:24:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:24:33 INFO - Running setup.py (path:/tmp/pip-rL0eqI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:24:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:24:33 INFO - Running setup.py (path:/tmp/pip-D1vmbE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:24:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:24:33 INFO - Running setup.py (path:/tmp/pip-Q3Zt7Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:24:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 02:24:33 INFO - Running setup.py (path:/tmp/pip-zc5CHT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 02:24:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 02:24:33 INFO - Running setup.py (path:/tmp/pip-of6Z6e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 02:24:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:24:33 INFO - Running setup.py install for manifestparser 02:24:33 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 02:24:33 INFO - Running setup.py install for mozcrash 02:24:33 INFO - Running setup.py install for mozdebug 02:24:34 INFO - Running setup.py install for mozdevice 02:24:34 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 02:24:34 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 02:24:34 INFO - Running setup.py install for mozfile 02:24:34 INFO - Running setup.py install for mozhttpd 02:24:34 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 02:24:34 INFO - Running setup.py install for mozinfo 02:24:34 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 02:24:34 INFO - Running setup.py install for mozInstall 02:24:34 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 02:24:34 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 02:24:34 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 02:24:34 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 02:24:34 INFO - Running setup.py install for mozleak 02:24:34 INFO - Running setup.py install for mozlog 02:24:34 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 02:24:34 INFO - Running setup.py install for moznetwork 02:24:34 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 02:24:34 INFO - Running setup.py install for mozprocess 02:24:34 INFO - Running setup.py install for mozprofile 02:24:35 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 02:24:35 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 02:24:35 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 02:24:35 INFO - Running setup.py install for mozrunner 02:24:35 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 02:24:35 INFO - Running setup.py install for mozscreenshot 02:24:35 INFO - Running setup.py install for moztest 02:24:35 INFO - Running setup.py install for mozversion 02:24:35 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 02:24:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:24:35 INFO - Cleaning up... 02:24:35 INFO - Return code: 0 02:24:35 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:24: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')]} 02:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24: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')]} 02:24:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:35 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 0x7f41d55fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x280c6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289b920>, '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 0x289c820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289ccb0>, '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': 'aa52b8aba932b19cc50b5275000001de-1457432638.584047-1465674945', '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 02:24:35 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 02:24:35 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 02:24:35 INFO - Using env: {'DISPLAY': ':0', 02:24:35 INFO - 'HOME': '/home/cltbld', 02:24:35 INFO - 'LANG': 'en_US.UTF-8', 02:24:35 INFO - 'LANGUAGE': 'en_US:en', 02:24:35 INFO - 'LOGNAME': 'cltbld', 02:24:35 INFO - 'MAIL': '/var/mail/cltbld', 02:24:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:35 INFO - 'MOZ_NO_REMOTE': '1', 02:24:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:35 INFO - 'NO_EM_RESTART': '1', 02:24:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:24:35 INFO - 'PWD': '/builds/slave/test-pgo', 02:24:35 INFO - 'SHELL': '/bin/bash', 02:24:35 INFO - 'SHLVL': '1', 02:24:35 INFO - 'TERM': 'linux', 02:24:35 INFO - 'TMOUT': '86400', 02:24:35 INFO - 'USER': 'cltbld', 02:24:35 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1457432638.584047-1465674945', 02:24:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:35 INFO - '_': '/tools/buildbot/bin/python'} 02:24:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:24:35 INFO - Running setup.py (path:/tmp/pip-ZeJrUK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:24:35 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)) 02:24:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:24:35 INFO - Running setup.py (path:/tmp/pip-WzCHBR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:24:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 02:24:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:24:35 INFO - Running setup.py (path:/tmp/pip-x0qZlu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:24:35 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)) 02:24:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:24:35 INFO - Running setup.py (path:/tmp/pip-ffYYqp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:24:36 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)) 02:24:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 02:24:36 INFO - Running setup.py (path:/tmp/pip-VMF2op-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 02:24:36 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)) 02:24:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:24:36 INFO - Running setup.py (path:/tmp/pip-H9KJ8N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:24:36 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)) 02:24:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:24:36 INFO - Running setup.py (path:/tmp/pip-8XNvbm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:24:36 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)) 02:24:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:24:36 INFO - Running setup.py (path:/tmp/pip-H9Zf6K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:24:36 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)) 02:24:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 02:24:36 INFO - Running setup.py (path:/tmp/pip-d6IJMV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 02:24:36 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)) 02:24:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 02:24:36 INFO - Running setup.py (path:/tmp/pip-ZJqdqg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 02:24:36 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)) 02:24:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:24:36 INFO - Running setup.py (path:/tmp/pip-3sLjWV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:24:36 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)) 02:24:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:24:36 INFO - Running setup.py (path:/tmp/pip-5gwcTW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:24:36 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)) 02:24:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:24:36 INFO - Running setup.py (path:/tmp/pip-ObiDe3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:24:36 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)) 02:24:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:24:36 INFO - Running setup.py (path:/tmp/pip-rovkaV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:24:36 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)) 02:24:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:24:36 INFO - Running setup.py (path:/tmp/pip-C0sVIm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:24:36 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)) 02:24:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 02:24:36 INFO - Running setup.py (path:/tmp/pip-fIxHoj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 02:24:36 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)) 02:24:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 02:24:36 INFO - Running setup.py (path:/tmp/pip-lHhkGu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 02:24:37 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)) 02:24:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 02:24:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 02:24:37 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)) 02:24:37 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)) 02:24:37 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)) 02:24:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 02:24:37 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 02:24:37 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 02:24:37 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 02:24:37 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 02:24:37 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 02:24:37 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 02:24:38 INFO - Downloading blessings-1.6.tar.gz 02:24:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 02:24:38 INFO - Installing collected packages: blessings 02:24:38 INFO - Running setup.py install for blessings 02:24:39 INFO - Successfully installed blessings 02:24:39 INFO - Cleaning up... 02:24:39 INFO - Return code: 0 02:24:39 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 02:24:39 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 02:24:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 02:24:39 INFO - Reading from file tmpfile_stdout 02:24:39 INFO - Current package versions: 02:24:39 INFO - argparse == 1.2.1 02:24:39 INFO - blessings == 1.6 02:24:39 INFO - blobuploader == 1.2.4 02:24:39 INFO - docopt == 0.6.1 02:24:39 INFO - manifestparser == 1.1 02:24:39 INFO - mozInstall == 1.12 02:24:39 INFO - mozcrash == 0.17 02:24:39 INFO - mozdebug == 0.1 02:24:39 INFO - mozdevice == 0.48 02:24:39 INFO - mozfile == 1.2 02:24:39 INFO - mozhttpd == 0.7 02:24:39 INFO - mozinfo == 0.9 02:24:39 INFO - mozleak == 0.1 02:24:39 INFO - mozlog == 3.1 02:24:39 INFO - moznetwork == 0.27 02:24:39 INFO - mozprocess == 0.22 02:24:39 INFO - mozprofile == 0.28 02:24:39 INFO - mozrunner == 6.11 02:24:39 INFO - mozscreenshot == 0.1 02:24:39 INFO - mozsystemmonitor == 0.0 02:24:39 INFO - moztest == 0.7 02:24:39 INFO - mozversion == 1.4 02:24:39 INFO - psutil == 3.1.1 02:24:39 INFO - requests == 1.2.3 02:24:39 INFO - wsgiref == 0.1.2 02:24:39 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:24:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:39 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 0x7f41d55fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x280c6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289b920>, '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 0x289c820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289ccb0>, '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': 'aa52b8aba932b19cc50b5275000001de-1457432638.584047-1465674945', '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 02:24:39 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 02:24:39 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 02:24:39 INFO - Using env: {'DISPLAY': ':0', 02:24:39 INFO - 'HOME': '/home/cltbld', 02:24:39 INFO - 'LANG': 'en_US.UTF-8', 02:24:39 INFO - 'LANGUAGE': 'en_US:en', 02:24:39 INFO - 'LOGNAME': 'cltbld', 02:24:39 INFO - 'MAIL': '/var/mail/cltbld', 02:24:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:39 INFO - 'MOZ_NO_REMOTE': '1', 02:24:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:39 INFO - 'NO_EM_RESTART': '1', 02:24:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:24:39 INFO - 'PWD': '/builds/slave/test-pgo', 02:24:39 INFO - 'SHELL': '/bin/bash', 02:24:39 INFO - 'SHLVL': '1', 02:24:39 INFO - 'TERM': 'linux', 02:24:39 INFO - 'TMOUT': '86400', 02:24:39 INFO - 'USER': 'cltbld', 02:24:39 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1457432638.584047-1465674945', 02:24:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:39 INFO - '_': '/tools/buildbot/bin/python'} 02:24:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:39 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)) 02:24:39 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)) 02:24:39 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)) 02:24:39 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)) 02:24:39 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)) 02:24:39 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)) 02:24:39 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)) 02:24:39 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)) 02:24:39 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)) 02:24:39 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)) 02:24:39 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)) 02:24:39 INFO - Cleaning up... 02:24:39 INFO - Return code: 0 02:24:39 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 02:24:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:39 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 0x7f41d55fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x280c6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289b920>, '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 0x289c820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289ccb0>, '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': 'aa52b8aba932b19cc50b5275000001de-1457432638.584047-1465674945', '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 02:24:39 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 02:24:39 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 02:24:39 INFO - Using env: {'DISPLAY': ':0', 02:24:39 INFO - 'HOME': '/home/cltbld', 02:24:39 INFO - 'LANG': 'en_US.UTF-8', 02:24:39 INFO - 'LANGUAGE': 'en_US:en', 02:24:39 INFO - 'LOGNAME': 'cltbld', 02:24:39 INFO - 'MAIL': '/var/mail/cltbld', 02:24:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:39 INFO - 'MOZ_NO_REMOTE': '1', 02:24:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:39 INFO - 'NO_EM_RESTART': '1', 02:24:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:24:39 INFO - 'PWD': '/builds/slave/test-pgo', 02:24:39 INFO - 'SHELL': '/bin/bash', 02:24:39 INFO - 'SHLVL': '1', 02:24:39 INFO - 'TERM': 'linux', 02:24:39 INFO - 'TMOUT': '86400', 02:24:39 INFO - 'USER': 'cltbld', 02:24:39 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1457432638.584047-1465674945', 02:24:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:39 INFO - '_': '/tools/buildbot/bin/python'} 02:24:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:39 INFO - Downloading/unpacking jsonschema 02:24:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:24:41 INFO - Downloading/unpacking functools32 (from jsonschema) 02:24: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 02:24: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 02:24: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 02:24: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 02:24: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 02:24: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 02:24:41 INFO - Downloading functools32-3.2.3-2.tar.gz 02:24:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 02:24:41 INFO - warning: no files found matching '*.txt' 02:24:41 INFO - no previously-included directories found matching 'build' 02:24:41 INFO - no previously-included directories found matching 'dist' 02:24:41 INFO - no previously-included directories found matching '.git*' 02:24:41 INFO - Installing collected packages: jsonschema, functools32 02:24:41 INFO - Running setup.py install for functools32 02:24:41 INFO - warning: no files found matching '*.txt' 02:24:41 INFO - no previously-included directories found matching 'build' 02:24:41 INFO - no previously-included directories found matching 'dist' 02:24:41 INFO - no previously-included directories found matching '.git*' 02:24:42 INFO - Successfully installed jsonschema functools32 02:24:42 INFO - Cleaning up... 02:24:42 INFO - Return code: 0 02:24:42 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 02:24:42 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')]} 02:24:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:42 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')]} 02:24:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:42 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 0x7f41d55fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x280c6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289b920>, '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 0x289c820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289ccb0>, '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': 'aa52b8aba932b19cc50b5275000001de-1457432638.584047-1465674945', '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 02:24:42 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 02:24:42 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 02:24:42 INFO - Using env: {'DISPLAY': ':0', 02:24:42 INFO - 'HOME': '/home/cltbld', 02:24:42 INFO - 'LANG': 'en_US.UTF-8', 02:24:42 INFO - 'LANGUAGE': 'en_US:en', 02:24:42 INFO - 'LOGNAME': 'cltbld', 02:24:42 INFO - 'MAIL': '/var/mail/cltbld', 02:24:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:42 INFO - 'MOZ_NO_REMOTE': '1', 02:24:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:42 INFO - 'NO_EM_RESTART': '1', 02:24:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:24:42 INFO - 'PWD': '/builds/slave/test-pgo', 02:24:42 INFO - 'SHELL': '/bin/bash', 02:24:42 INFO - 'SHLVL': '1', 02:24:42 INFO - 'TERM': 'linux', 02:24:42 INFO - 'TMOUT': '86400', 02:24:42 INFO - 'USER': 'cltbld', 02:24:42 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1457432638.584047-1465674945', 02:24:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:42 INFO - '_': '/tools/buildbot/bin/python'} 02:24:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:42 INFO - Downloading/unpacking flake8 02:24:42 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 02:24:42 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 02:24:42 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 02:24:42 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 02:24:42 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 02:24:42 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 02:24:44 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:24:44 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:24:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:44 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:24:44 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:24:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:44 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:24:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 02:24:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:24:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:24:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:24:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:24:44 INFO - no previously-included directories found matching 'docs/_build' 02:24:44 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:24:44 INFO - Running setup.py install for pep8 02:24:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:24:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:24:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:24:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:24:44 INFO - no previously-included directories found matching 'docs/_build' 02:24:45 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 02:24:45 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:24:45 INFO - Cleaning up... 02:24:45 INFO - Return code: 0 02:24:45 INFO - Running post-action listener: _resource_record_post_action 02:24:45 INFO - Running post-action listener: _start_resource_monitoring 02:24:45 INFO - Starting resource monitoring. 02:24:45 INFO - ##### 02:24:45 INFO - ##### Running install step. 02:24:45 INFO - ##### 02:24:45 INFO - Running pre-action listener: _resource_record_pre_action 02:24:45 INFO - Running main action method: install 02:24:45 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 02:24:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 02:24:45 INFO - Reading from file tmpfile_stdout 02:24:45 INFO - Detecting whether we're running mozinstall >=1.0... 02:24:45 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 02:24:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 02:24:45 INFO - Reading from file tmpfile_stdout 02:24:45 INFO - Output received: 02:24:45 INFO - Usage: mozinstall [options] installer 02:24:45 INFO - Options: 02:24:45 INFO - -h, --help show this help message and exit 02:24:45 INFO - -d DEST, --destination=DEST 02:24:45 INFO - Directory to install application into. [default: 02:24:45 INFO - "/builds/slave/test-pgo"] 02:24:45 INFO - --app=APP Application being installed. [default: firefox] 02:24:45 INFO - mkdir: /builds/slave/test-pgo/build/application 02:24:45 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'] 02:24:45 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 02:25:01 INFO - Reading from file tmpfile_stdout 02:25:01 INFO - Output received: 02:25:01 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 02:25:01 INFO - Running post-action listener: _resource_record_post_action 02:25:01 INFO - ##### 02:25:01 INFO - ##### Running run-tests step. 02:25:01 INFO - ##### 02:25:01 INFO - Running pre-action listener: _resource_record_pre_action 02:25:01 INFO - Running main action method: run_tests 02:25:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 02:25:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 02:25:01 INFO - Python 2.7.3 02:25:01 INFO - Return code: 0 02:25:01 INFO - grabbing minidump binary from tooltool 02:25:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:25:01 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 0x289b920>, '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 0x289c820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289ccb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 02:25:01 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 02:25:01 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 02:25:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:25:01 INFO - Return code: 0 02:25:01 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 02:25:01 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 02:25:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 02:25:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 02:25:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 02:25:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 02:25:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 02:25:02 INFO - Return code: 0 02:25:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DXC_oMDVQqezRTaaZpA3IQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 02:25:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DXC_oMDVQqezRTaaZpA3IQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 02:25:02 INFO - Using env: {'DISPLAY': ':0', 02:25:02 INFO - 'HOME': '/home/cltbld', 02:25:02 INFO - 'LANG': 'en_US.UTF-8', 02:25:02 INFO - 'LANGUAGE': 'en_US:en', 02:25:02 INFO - 'LOGNAME': 'cltbld', 02:25:02 INFO - 'MAIL': '/var/mail/cltbld', 02:25:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 02:25:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 02:25:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:25:02 INFO - 'MOZ_NO_REMOTE': '1', 02:25:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 02:25:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:25:02 INFO - 'NO_EM_RESTART': '1', 02:25:02 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:25:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:25:02 INFO - 'PWD': '/builds/slave/test-pgo', 02:25:02 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 02:25:02 INFO - 'SHELL': '/bin/bash', 02:25:02 INFO - 'SHLVL': '1', 02:25:02 INFO - 'TERM': 'linux', 02:25:02 INFO - 'TMOUT': '86400', 02:25:02 INFO - 'USER': 'cltbld', 02:25:02 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1457432638.584047-1465674945', 02:25:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:25:02 INFO - '_': '/tools/buildbot/bin/python'} 02:25:02 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DXC_oMDVQqezRTaaZpA3IQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:25:02 INFO - mozversion application_buildid: 20160307110832 02:25:02 INFO - mozversion application_changeset: a06ac8e3220aa7bb49f5b755936078772a2b7464 02:25:02 INFO - mozversion application_display_name: Nightly 02:25:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:25:02 INFO - mozversion application_name: Firefox 02:25:02 INFO - mozversion application_remotingname: firefox 02:25:02 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:25:02 INFO - mozversion application_vendor: Mozilla 02:25:02 INFO - mozversion application_version: 47.0a1 02:25:02 INFO - mozversion platform_buildid: 20160307110832 02:25:02 INFO - mozversion platform_changeset: a06ac8e3220aa7bb49f5b755936078772a2b7464 02:25:02 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:25:02 INFO - mozversion platform_version: 47.0a1 02:25:02 INFO - using testdate: 1457432702 02:25:02 INFO - actual date: 1457432702 02:25:02 INFO - starting webserver on 'localhost:47156' 02:25:02 INFO - SUITE-START | Running 2 tests 02:25:02 INFO - TEST-START | dromaeo_css 02:25:02 INFO - operating with platform_type : linux_ 02:25:02 INFO - Initialising browser for dromaeo_css test... 02:25:02 INFO - TEST-INFO | started process 14496 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpM8ObYY/profile http://localhost:47156/getInfo.html) 02:25:07 INFO - PROCESS | 14496 | __metrics Screen width/height:1600/1200 02:25:07 INFO - PROCESS | 14496 | colorDepth:24 02:25:07 INFO - PROCESS | 14496 | Browser inner width/height: 1024/697 02:25:07 INFO - PROCESS | 14496 | __metrics 02:25:08 INFO - PROCESS | 14496 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:25:09 INFO - TEST-INFO | 14496: exit 0 02:25:09 INFO - Browser initialized. 02:25:09 INFO - Running cycle 1/1 for dromaeo_css test... 02:25:09 INFO - TEST-INFO | started process 14592 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpM8ObYY/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:25:21 INFO - PROCESS | 14592 | RSS: Main: 153673728 02:25:21 INFO - PROCESS | 14592 | 02:26:11 INFO - PROCESS | 14592 | 1457432771710 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] 02:28:20 INFO - PROCESS | 14592 | Cycle 1(1): loaded http://localhost:47156/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47156/tests/dromaeo/cssquery-ext.html) 02:28:21 INFO - PROCESS | 14592 | RSS: Main: 259670016 02:28:21 INFO - PROCESS | 14592 | 02:31:23 INFO - PROCESS | 14592 | Cycle 1(1): loaded http://localhost:47156/tests/dromaeo/cssquery-ext.html (next: http://localhost:47156/tests/dromaeo/cssquery-jquery.html) 02:31:24 INFO - PROCESS | 14592 | RSS: Main: 236695552 02:31:24 INFO - PROCESS | 14592 | 02:34:26 INFO - PROCESS | 14592 | Cycle 1(1): loaded http://localhost:47156/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47156/tests/dromaeo/cssquery-mootools.html) 02:34:26 INFO - PROCESS | 14592 | RSS: Main: 244084736 02:34:26 INFO - PROCESS | 14592 | 02:37:28 INFO - PROCESS | 14592 | Cycle 1(1): loaded http://localhost:47156/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47156/tests/dromaeo/cssquery-prototype.html) 02:37:29 INFO - PROCESS | 14592 | RSS: Main: 219226112 02:37:29 INFO - PROCESS | 14592 | 02:40:31 INFO - PROCESS | 14592 | Cycle 1(1): loaded http://localhost:47156/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47156/tests/dromaeo/cssquery-yui.html) 02:40:32 INFO - PROCESS | 14592 | RSS: Main: 218206208 02:40:32 INFO - PROCESS | 14592 | 02:43:35 INFO - PROCESS | 14592 | Cycle 1(1): loaded http://localhost:47156/tests/dromaeo/cssquery-yui.html (next: http://localhost:47156/tests/dromaeo/cssquery-dojo.html) 02:43:35 INFO - PROCESS | 14592 | RSS: Main: 268525568 02:43:35 INFO - PROCESS | 14592 | 02:43:35 INFO - PROCESS | 14592 | __start_tp_report 02:43:35 INFO - PROCESS | 14592 | _x_x_mozilla_page_load 02:43:35 INFO - PROCESS | 14592 | _x_x_mozilla_page_load_details 02:43:35 INFO - PROCESS | 14592 | |i|pagename|runs| 02:43:35 INFO - PROCESS | 14592 | |0;dojo.html;3085.706857848504;3160.9051728448153;3197;3202.1514298710845;3229.208843833261;5061;5076.5684916782075;5106.795728170878;5133.48665133487;5139.640225184238;5071.2139618359215;5072.365954255718;5074.568661663754;5094.388673359193;5159.767810448529;4640.2343613303765;4665.183592871243;4711.575958163765;4752.691075080109;4780.737059461728;4603.263477843546;4656.7205967641885;4733.59764420023;4759.547842954914;4860.756962151896;4605.815767369301;4617.561331673485;4622.306654001893;4637.768111594407;4687.92968105477;4623.0984957933215;4635.374224479686;4635.930461043087;4638.234691275936;4645.256758918556;4547.545245475426;4604.401427814396;4605.37827393301;4617.930731039037;4711.575958163748;5007.949920500785;5019.824306149268;5020.196768517057;5067.6452648314635;5085.720285384303;5570.387257401682;5571.387147413781;5573.136163894603;5584.190292407578;5633.40849210831;5425.104857698515;5567.554595632339;5589.273394458735;5611.130274807411;5628.296462942132;5153.793848246066;5168.328117344721;5176.534111929906;5227.163653815372;5235.450277720823;5662.405447427961;5663.886722265532;5665.951798917214;5669.007923613433;5669.206311116447;5313.1764576490705;5317.973410133002;5323.574114070865;5361.142217245222;5388.46115388458;5558.166275058774;5586.441355864381;5595.188697638901;5598.524125449301;5611.859703507445;5400.378956420062;5498.120300751941;5561.140695764727;5561.360443548962;5605.103183490622;5376.193570964387;5410;5415.350157981067;5443.836684899459;5464.153056276284;4135.29699951009;4136.084060737173;4145.585441455891;4148.253314403436;4172.123853990635;3733.2720119576966;3742.5321834770652;3798.031501967036;3803.82882770276;3803.847846086181;5240.449752775904;5240.475952404805;5260.079486089995;5267.078261304257;5317.468253174651;5527.060399732055;5573.832785016456;5579.414161513064;5584.190292407578;5628.915566266509;4960.553550180501;5001.924971125436;5111.028904508132;5206.843794686166;5276.841694749087;4640.883977900512;4651.930221046687;4659.347691323217;4696.131215725101;4712.081144176921;5744.454276843693;5746.339170995306;5749.080147176432;5749.1663708762;5757.4242575741255;5362.812301569426;5418.295621569171;5442.319710036246;5493;5527.917081243704;5736.913946290892;5751.712414379348;5755.309362876482;5755.482006619257;5759.136129580596;5440.863978400572;5448.291722076105;5456.48163424474;5458.4814442627885;5463.153211252262;5271.604629652715;5299.788008479618;5321.3880403754065;5380.650257733235;5535.667859928417;5372.946270537401;5374.11327131019;5376.301080859464;5381.461853814587;5388.245645609696;5383.380911195262;5385.4076051635075;5387.299651045339;5390.541803946709;5431.9728401359325;5201.271821944855;5348.197770334481;5374;5376.435474275145;5431.538319242909;5364.678119312854;5375.00562395958;5398.62209645321;5404.459554044722;5455.918161227505;5169.4830516948;5271.8682032947945;5296.2055691646565;5297.629165958346;5298.8940221196135 02:43:35 INFO - PROCESS | 14592 | |1;ext.html;488.8899997500563;523.3667262612239;531.1793279383352;545.5281181777762;605.4520658803784;28955.710442895564;29677.703222967764;37764.24471510571;38150.618493815055;38303.808480957625;40918;41013.794931025375;41309.17381652365;41528.96177595561;41753.79123104388;7408.666610002563;8490.235878770925;8733.868991965126;8741;8745.125487451267;7522.774316770506;7639.809004774869;10395.74010649736;10600.681979540626;10603.257771955927;10336.069753722164;10422.114120299784;10424.166066714683;10426.270161088727;10431.217658675592;10154.187664986783;10163.288569800117;10265.538050787733;10266;10270.845937310947;10149.797004059952;10243.692689219335;10265.640702575449;10287.845682314772;10291.639792607297;38203.23593528114;38716.22567548662;42480.57519424828;42492.36261456081;42548.36177457341;3354.2285274387027;3392.9321413571593;3522.7005704515145;3592.8742494012586;3775.5091838061153;30812.628730062548;31442.21394465134;31865.84067079673;31873;33649.83175084133;3623.691986181178;3625.7099432045375;3695.3533131701843;3700.9444858327147;3718.851245950159;275999;277068.99999999796;278555;278682;278791;44607.55392446034;61877.690611546655;62287.68856155781;62362.68818655878;62477.687611561654;44334.55665443304;44540;44629.77685111554;44632;44675.55324446779;15389.461368852037;15537.68924621524;15617.531474055797;15631.140287284308;15636;10149.949250253701;12499.312537810507;12656.81014784779;12675.669054749304;12681.873181268254;14403.711925761427;14537.563873083824;14556.344964476411;14592.927035364755;14599.197044162673;5505.119180931112;5603.691796951207;5673.858153546194;5676.545876329967;5683.147527870769;831.667333066766;896.9372143949861;929.5352323838081;971.4608392342318;1029.629333439961;26805.86597067002;28335.858320708263;29487.26281842971;29744.321583968464;30127;1060.8461773042866;1063.1813503602339;1084.38732116354;1168.485866218861;1188.5958774016876;14984.325705343286;15556.377744890078;15572.84427155714;15655.217239137997;15819.762703559456;302833;303528;305234;306314;306917;54601.45398546043;55426;55459.445405546234;55471;55515;1166.3701601135463;1339.9933000334936;1344.677277453404;1358.5041459867275;1361.9931900340632;26984.730152698223;29687.25781855471;29837.254068648457;30042.69957300399;30049.399012020076;41111;42016;42079;42083.36874946817;42593.57406425896;180440;183099;184703;191384;195194;27306.45387092287;31720.36559268848;31929.521057183698;32766.344673105927;32866.67133328636;38948.80525597467;42625.36061959011;43061.56938430575;43542.56457435385;44012.779936100116;35268.82365588258;35737.821310893276;35894.28211435809;36024.27951440904;36500;36100;36145;36274.455883161245;36472.27055458929;36485;33987;36665.45001825028;36792;37142.44286335653;37146.44280335743;31305;35553.28893422169;38100.237995240495;39068;39649.40525892172;24196.87901560481;24244.151454699;24253.151139710026;24567.50864982726;24802.50394992054 02:43:35 INFO - PROCESS | 14592 | |2;jquery.html;307.84607696151926;338.700200948953;351.7063252184426;352.36398301066566;370.1191165027235;16797.916010419947;17359.132043397825;17731.379401720926;18254;18289.817101829012;10900.672979810599;11445.656630301084;16834.24245908934;16902.83097169028;16914.407995720154;4956.653034287592;5129;5156.664816786915;5189.299444574991;5598.580106492009;5486.204500347447;5489.011977843987;5567.109262517998;5576.693281869496;5579;5516.14499752539;5518.889622207554;5531.2809334786425;5532.640378375413;5598.804041858536;5772.191893134965;5775.306963164405;5796.942030579682;5801.941980580204;5807.2160258365;4985.626078044161;5153.768080436389;5165.9225111623355;5209.947900520984;5213.244079608436;13079.28063956482;13143;13486.595402137853;20166.899165504226;20395.89802050995;2211.0934516848174;2302.5625131225183;2331.440454290958;2485.2792690119845;2493.9376515587073;9038.593263303168;9198.770030749218;9213.953930230373;9222.953885230598;9612.327137100407;1860.6185731924922;1878.8121187881238;1890.5273681579606;1911.7705875294914;1933.4006457997925;62347;63860.3613963859;64090.35909640891;64641.03038454427;65293.673531632514;9581.856272155923;9757.316987810927;10207.948960255151;10247.231457640706;10410.219233557513;13577.253251071088;13660.65848353799;13668;13710.794338084937;13717.245551494763;7597.696092156362;7665.808354791064;7740;7777.883331750028;7822.765317040498;7608.619569021526;7613.505122167041;7694.499857509244;7728.304452599293;7738.806529836799;4492.483364413069;4531.932021019687;4578.610818080434;4619.145458090197;4636.211843986531;1701.6936951348628;1793.6950718377907;1795.9281628734966;1813.9909300453678;1814.4738025972583;885.2873436883242;886.1094599927033;900.7567956651667;914.7347269291964;964.4165280005636;15092.54722358331;15557.688846223013;16408.26162822676;16752;16929.83070169307;839.2404873589411;878.3675753457501;921.5944984206927;940.6049459227141;1035.3115178406276;9459.952700236592;9771.755706107404;9780;9832.9016709832;9941.900580994097;336815;345731;441774;446571;447670;67485.32514674889;67619.66190169018;68641.65679171572;73084.63457682784;74561.62719186369;878.508035500122;890.512843551271;904.6788390121412;906.392716879679;999.5102399824034;14460.27698615086;15396.769048464057;15529.611759706098;15581.532554023397;15836.60408489797;33584.16039599029;33606.159846003065;33828.83085584556;34319;34350;44726.552734472236;45332.54667453283;45676;45770.771146144056;45940.54059459496;7967.28294453502;7974.322182614543;8104.27061564462;8300.87548686758;8328.458650187718;6668.566543174678;9798.65704700332;10562.260641755003;12513;12559.246445213317;10604;10670.679879603624;10830;11010.229283950366;11107.833382499108;10789.352638841694;10952.397618131079;11004.229703920648;11157.832632510681;11241.100711942861;6549.934500655123;10523;10686.465676715978;11037.779244415227;11167.888321116685;7959.4030447715495;8006.079300880473;8010.399220058635;8065.1934806518875;8194.754157375288;8559;10527.315724477885;10789.946050270013;10970.177236707119;10992.230543861853 02:43:35 INFO - PROCESS | 14592 | |3;mootools.html;1364.3655700099453;1482.5700546841417;1513.447591629055;1696.9575760605983;1873.1289950173175;7539.886901696472;7756.767296981093;7761.379089672812;7769.922300776991;7777.533347999117;7595.4683172177965;7757.573333466671;7778.766637000899;7782;7782.260685234908;1990;2255.3459496745922;2280.7605201453857;2286.3941055620276;2352.741198468167;2334.0313769785603;2339.532093581282;2341.098677009355;2341.5785158671433;2342.847714898535;2240.831937604678;2288.7253529576474;2290.209877592228;2290.473191166033;2290.6564015397657;2248.685184074231;2269.2511471214543;2352.882355882199;2353.423411264234;2354.505553833697;2305.3660243433023;2315.895784689676;2330.568844763724;2331.2889568681544;2332.5101728637005;7890.289873911375;8049.557274349967;8073.233042860918;8079.232472915063;8088.029436467603;4839.298301746262;4961.206207006898;4971.45314015458;5007.098722229997;5016.072026675077;3027.6366835979825;3118.1269244611544;3157.068664743906;3177.698118678722;3198.6641402652854;920.5489310238003;925.4724806860092;934.9672761453317;947.3652652722692;953.208836665566;11155.609553665663;11177.49701263445;11214.887851121466;11238.606648767254;11252.606158784403;4423;4549.181147393435;4610.74640894754;4619.538046195421;4626.6298696104905;9437.716868493957;9462.905370946202;9479.715608531755;9494.430334179833;9502.524873756423;4433.401490798766;5010.048090862724;5038.949610503922;5040.647154699136;5044.142495775727;4239.8092085856215;4277.529471758104;4312.05134870328;4357;4374.409454723572;3722.3485889969147;3785.621437856247;3794.29805485986;3815.923681526354;3841.1357444574746;1202.2065436811663;1205.764875849201;1212.0545974140184;1222.7004383925816;1226.1294480918468;1329.7407005633809;1379.8206233189621;1380;1388.9444422222998;1398.8741013308852;7456.925430745623;7512.849743005109;7571.318581327597;7602.543847369065;7610.543367397974;490.3478373762887;491.4913064977802;497.9751012449363;498.006477078224;508.19451169895393;5780.248567686258;5795.420457954171;5818.5345172386105;5869.970650146807;5873;9231.861522077174;9886.209103271722;10008.049235322633;10010.349327293703;10031.047050530187;9724.465154416434;9776.364536305118;9776.462294573725;9788.168005719452;9794.65718699842;7407.148177959496;7611.733589324347;7618.847623047619;7630.656620452093;7724.497907636098;7241.239669834592;7270.018547496232;7272.5636461810345;7318.451116166202;7358.411327093712;8422.368322375723;8699.956500217459;8724.083971182934;8736.650533978824;8821.073787252246;8480.533570653673;8610.827783444422;8643.308535317285;8747.212750852454;8834.381593288408;6049.153118563317;6657.833554161185;6784.626845523544;6792.898106528505;6928.307169283032;7541;7572.659230334538;7581.166071732216;7615.352695020763;7630.504017238862;6691.698873550605;6822.420094292041;6841.247462778991;6968.547044442095;7000.649967501503;6724.29394913527;6781;6838.076859623887;6931.064306318583;6951.721931122698;6869.828254293682;7071.186813516511;7106.609136497542;7114.075170227838;7115.6086415247655;6564.934350656432;6579.144711187515;6600.900986485302;6607.174103237096;6620.569662971891;6483.4164925156965;6627.370399812203;6630.403263706289;6651.63416012124;6667.066610674412 02:43:35 INFO - PROCESS | 14592 | |4;prototype.html;328.4334522947914;328.88160262305564;330.14821759859564;331.2893842707393;337.1907422186752;5800;5807.709614519273;5823.475887170154;5874.853128671785;5884.176215329847;5799.217105690731;5801.564882633809;5805.24531810865;5820.330661973874;5826.737796799143;4294.570542945712;4382.057857560624;4467.352233926079;4478.23869942109;4482.238019536687;4467.039586488904;4480.148771733377;4498.077894031732;4502.279635258359;4504.436945381827;4266.658667306608;4454.309582014793;4457.621102206316;4460.754658493782;4464.933026004596;4319.308910574325;4350.8912277193;4351.6953813233085;4381.255186618282;4391.143726973241;3808.8666896658483;3838.136419305662;3845.5000849889616;3851.2490064437447;3857.498525191735;5528.889422211573;5539.612227144102;5556.666600003972;5557.5553955683445;5560.026995275851;5105.412877519096;5118.436971933084;5127.7948882044675;5131.050755610224;5133.358330208724;6074.908876366858;6087.05650624154;6109.266887973472;6122.204113465221;6123.2039834821635;4152.065785198336;4198.517170525398;4238.279492486254;4238.491381034265;4242.151569686044;6358.554901156921;6371.553991220617;6385.361463853577;6388.488920886364;6398.9040164397575;4302.419173411612;4330.566943305645;4332.523422423531;4334.566543345703;4336.674749393808;4391.538888416734;4391.692581519327;4394.209042372404;4394.934075988863;4395.384646149541;5091.8981620367385;5095.617828662865;5095.617828662865;5097.592192624581;5099.36257967754;5982.700864956735;6184.783532576428;6192.81421557354;6194.946859033975;6195.287541932646;1520.7642815363636;1530.732121878689;1538.2001359293106;1539.7767323737996;1542.1441100189502;952.6094301336419;993.294760719897;1019.1541020952592;1022.7443139215196;1036.3988886445843;5841.299044114733;5923.911141332884;5933.732982015819;5988.431099045583;5989.610675306091;6377.426031657174;6388.169537960035;6388.968055159788;6440.774572889926;6452.870942581122;5966.31387390447;5968;5970.253718285215;5970.641761494324;5975.223220981332;3399.932001359959;3428.3143371325837;3429.9828500857334;3431.673990970854;3433.038749150242;6525.249596296487;6697.598144111369;6713.731450741916;6724.260331363546;6731.966340168366;6516.706748196342;6517.706703198272;6531;6531.444827189647;6534.183227096613;6689.2307384651385;6692.498062645321;6693.330666933365;6694.297098804555;6696.229933557605;6361.268454127649;6367.299597044229;6370.140031095742;6372.139761132374;6372.235331760218;6146.754129834935;6303.527235457267;6310.085037669604;6311.621302721851;6312.684365781784;6715.3620406061345;6740.831479213059;6747.966260168668;6753.459723222229;6754.493412994143;4299.849505267301;4343.19650864591;4344;4350.651947844101;4351.608355248043;6380.553361264667;6408.03879418091;6422.486201103994;6426;6440.871182576416;6244.906326405016;6245.656488893154;6298.874022519615;6312.021636646327;6321.620702757849;6015.849603759941;6198.318184999736;6241.6879156041105;6250.343713910156;6251.562390632612;6112.724927378367;6120.081987701702;6134.693265336805;6139.754409823557;6145.170401995852;6268.52986026059;6269.247690277196;6270.843228919131;6275.874482510416;6277.435030847246;5861.974154523026;6123.969380153071;6126.571140020156;6132.264128304453;6133.355997620186 02:43:35 INFO - PROCESS | 14592 | |5;yui.html;741.9591922444266;786.4554888039321;821.2157389692844;839.6053854688298;861.207688926188;13748.175109493424;14017.088889222194;14072.64818379541;14088.154710717365;14088.295585220749;12265.293006989517;12440.626781196555;12464.31446270457;12517;12522.874771252285;825.9834803303916;840.3361344537839;841.9915800842005;843.4981186194204;844.3498506150261;830.8089139497919;832.6544484039116;837.9581020948929;838.2497664590219;838.4214891724721;874.9387542872001;875.1030194051085;877.5305211711735;878.4377998081233;879.2921698033081;871.037503558565;871.6644092024553;871.6861929705365;871.9520426376547;874.1040433555625;644.1465058797113;644.954853160279;645.1548471502347;646.5894157210205;646.7186773753385;12796;12863.485460581565;12873.549425770147;12882.742345153138;12906.35468226585;11471.942640286745;11863.406829658483;12035;12108;12211.511539538407;10805;11499.540018399253;11612.941935290353;11698.415079246004;12000.759984800256;3586.569611646593;3613.403788374915;3651.3610118229203;3722.4788529605876;3724.515812944327;46687.533124668655;46944.7652761734;46956;47021.529784702056;51616.48383516154;8284.792880177924;10156.746081348025;10249.743756406;10367.118794902366;10685.946570267255;17102.48692539226;17185.226664800113;17250.482485525456;17266.22301996413;17268.568285792957;6718.395344418928;6805.183377994672;6822.147231596051;6836.623985680736;7342.963285183647;4109.650679692199;4161.687873409506;4162.125953549788;4259.446271984622;4445.866624001285;3151.7636177286795;3177.4757165067967;3182.9681703183137;3192.74458043356;3199.936001279961;605.1709158452948;610.697704636208;618.0790621973317;619.5446346934999;624.0483263023925;632.3202557250974;659.3735950846715;659.8977158540434;661.4528232863009;679.6092246958019;8355;8688.782780430414;8774.254188394058;8784.824303513893;8827.272184995918;479.52287473962934;597.3369559788631;623.7006237006262;644.5359341274275;665.4044630056072;4060.6954478414236;4151.8962025949595;4178.477690288714;4233.153369326147;4261.595148460891;51937.220941685904;53987;54099;54278.72860635751;54587.727061364436;47383.5261647386;48518.78703032452;48612.027759444616;48665.27002094971;48804.51195488;39991.60008399937;42558.78720606439;44500;49136;49868.750656246484;8952.507612081397;9068.818623627358;9081;9129.497877616795;9300.11648893354;33925.83037084799;34652;34951;35403;35507.46738798972;42576;43795.12409751723;44021.55978440175;44155.337669935616;44586;10769.299995500267;10890.549626334012;11313.943430282796;11332.490037948148;11429.19940656072;12505.687357816127;12541.686457838627;12762.553310634083;12804.743905122032;12911.5480958166;11124.721881953015;11306.152038597302;11387.772244555228;11747.823782643096;12178.57374991871;11197.88802112001;11201.495932683212;11883.702907427038;12149.939250303692;12154.270743755404;11448.542058317575;11710.473028713557;11716.765664686489;11976.221545599508;12037.879621203676;9240.168384845127;9418.293627977791;9464.621415143318;9542.666006689733;9733.124018838338;9584.731230895623;9755.756106097404;9984.60061597528;10160.136388407069;10262.179025677779 02:43:35 INFO - PROCESS | 14592 | __end_tp_report 02:43:35 INFO - PROCESS | 14592 | __start_cc_report 02:43:35 INFO - PROCESS | 14592 | _x_x_mozilla_cycle_collect,821 02:43:35 INFO - PROCESS | 14592 | __end_cc_report 02:43:35 INFO - PROCESS | 14592 | __startTimestamp1457433815852__endTimestamp 02:43:35 INFO - PROCESS | 14592 | 02:43:35 INFO - PROCESS | 14592 | ------- Summary: start ------- 02:43:35 INFO - PROCESS | 14592 | Number of tests: 6 02:43:35 INFO - PROCESS | 14592 | 02:43:35 INFO - PROCESS | 14592 | [#0] dojo.html Cycles:165 Average:5112.84 Median:5313.18 stddev:571.30 (10.8%) stddev-sans-first:550.48 02:43:35 INFO - PROCESS | 14592 | Values: 3085.7 3160.9 3197.0 3202.2 3229.2 5061.0 5076.6 5106.8 5133.5 5139.6 5071.2 5072.4 5074.6 5094.4 5159.8 4640.2 4665.2 4711.6 4752.7 4780.7 4603.3 4656.7 4733.6 4759.5 4860.8 4605.8 4617.6 4622.3 4637.8 4687.9 4623.1 4635.4 4635.9 4638.2 4645.3 4547.5 4604.4 4605.4 4617.9 4711.6 5007.9 5019.8 5020.2 5067.6 5085.7 5570.4 5571.4 5573.1 5584.2 5633.4 5425.1 5567.6 5589.3 5611.1 5628.3 5153.8 5168.3 5176.5 5227.2 5235.5 5662.4 5663.9 5666.0 5669.0 5669.2 5313.2 5318.0 5323.6 5361.1 5388.5 5558.2 5586.4 5595.2 5598.5 5611.9 5400.4 5498.1 5561.1 5561.4 5605.1 5376.2 5410.0 5415.4 5443.8 5464.2 4135.3 4136.1 4145.6 4148.3 4172.1 3733.3 3742.5 3798.0 3803.8 3803.8 5240.4 5240.5 5260.1 5267.1 5317.5 5527.1 5573.8 5579.4 5584.2 5628.9 4960.6 5001.9 5111.0 5206.8 5276.8 4640.9 4651.9 4659.3 4696.1 4712.1 5744.5 5746.3 5749.1 5749.2 5757.4 5362.8 5418.3 5442.3 5493.0 5527.9 5736.9 5751.7 5755.3 5755.5 5759.1 5440.9 5448.3 5456.5 5458.5 5463.2 5271.6 5299.8 5321.4 5380.7 5535.7 5372.9 5374.1 5376.3 5381.5 5388.2 5383.4 5385.4 5387.3 5390.5 5432.0 5201.3 5348.2 5374.0 5376.4 5431.5 5364.7 5375.0 5398.6 5404.5 5455.9 5169.5 5271.9 5296.2 5297.6 5298.9 02:43:35 INFO - PROCESS | 14592 | 02:43:35 INFO - PROCESS | 14592 | [#1] ext.html Cycles:180 Average:42882.83 Median:18110.45 stddev:68227.21 (376.7%) stddev-sans-first:68344.35 02:43:35 INFO - PROCESS | 14592 | Values: 488.9 523.4 531.2 545.5 605.5 28955.7 29677.7 37764.2 38150.6 38303.8 40918.0 41013.8 41309.2 41529.0 41753.8 7408.7 8490.2 8733.9 8741.0 8745.1 7522.8 7639.8 10395.7 10600.7 10603.3 10336.1 10422.1 10424.2 10426.3 10431.2 10154.2 10163.3 10265.5 10266.0 10270.8 10149.8 10243.7 10265.6 10287.8 10291.6 38203.2 38716.2 42480.6 42492.4 42548.4 3354.2 3392.9 3522.7 3592.9 3775.5 30812.6 31442.2 31865.8 31873.0 33649.8 3623.7 3625.7 3695.4 3700.9 3718.9 275999.0 277069.0 278555.0 278682.0 278791.0 44607.6 61877.7 62287.7 62362.7 62477.7 44334.6 44540.0 44629.8 44632.0 44675.6 15389.5 15537.7 15617.5 15631.1 15636.0 10149.9 12499.3 12656.8 12675.7 12681.9 14403.7 14537.6 14556.3 14592.9 14599.2 5505.1 5603.7 5673.9 5676.5 5683.1 831.7 896.9 929.5 971.5 1029.6 26805.9 28335.9 29487.3 29744.3 30127.0 1060.8 1063.2 1084.4 1168.5 1188.6 14984.3 15556.4 15572.8 15655.2 15819.8 302833.0 303528.0 305234.0 306314.0 306917.0 54601.5 55426.0 55459.4 55471.0 55515.0 1166.4 1340.0 1344.7 1358.5 1362.0 26984.7 29687.3 29837.3 30042.7 30049.4 41111.0 42016.0 42079.0 42083.4 42593.6 180440.0 183099.0 184703.0 191384.0 195194.0 27306.5 31720.4 31929.5 32766.3 32866.7 38948.8 42625.4 43061.6 43542.6 44012.8 35268.8 35737.8 35894.3 36024.3 36500.0 36100.0 36145.0 36274.5 36472.3 36485.0 33987.0 36665.5 36792.0 37142.4 37146.4 31305.0 35553.3 38100.2 39068.0 39649.4 24196.9 24244.2 24253.2 24567.5 24802.5 02:43:35 INFO - PROCESS | 14592 | 02:43:35 INFO - PROCESS | 14592 | [#2] jquery.html Cycles:180 Average:24033.35 Median:25174.69 stddev:66819.33 (265.4%) stddev-sans-first:66983.02 02:43:35 INFO - PROCESS | 14592 | Values: 307.8 338.7 351.7 352.4 370.1 16797.9 17359.1 17731.4 18254.0 18289.8 10900.7 11445.7 16834.2 16902.8 16914.4 4956.7 5129.0 5156.7 5189.3 5598.6 5486.2 5489.0 5567.1 5576.7 5579.0 5516.1 5518.9 5531.3 5532.6 5598.8 5772.2 5775.3 5796.9 5801.9 5807.2 4985.6 5153.8 5165.9 5209.9 5213.2 13079.3 13143.0 13486.6 20166.9 20395.9 2211.1 2302.6 2331.4 2485.3 2493.9 9038.6 9198.8 9214.0 9223.0 9612.3 1860.6 1878.8 1890.5 1911.8 1933.4 62347.0 63860.4 64090.4 64641.0 65293.7 9581.9 9757.3 10207.9 10247.2 10410.2 13577.3 13660.7 13668.0 13710.8 13717.2 7597.7 7665.8 7740.0 7777.9 7822.8 7608.6 7613.5 7694.5 7728.3 7738.8 4492.5 4531.9 4578.6 4619.1 4636.2 1701.7 1793.7 1795.9 1814.0 1814.5 885.3 886.1 900.8 914.7 964.4 15092.5 15557.7 16408.3 16752.0 16929.8 839.2 878.4 921.6 940.6 1035.3 9460.0 9771.8 9780.0 9832.9 9941.9 336815.0 345731.0 441774.0 446571.0 447670.0 67485.3 67619.7 68641.7 73084.6 74561.6 878.5 890.5 904.7 906.4 999.5 14460.3 15396.8 15529.6 15581.5 15836.6 33584.2 33606.2 33828.8 34319.0 34350.0 44726.6 45332.5 45676.0 45770.8 45940.5 7967.3 7974.3 8104.3 8300.9 8328.5 6668.6 9798.7 10562.3 12513.0 12559.2 10604.0 10670.7 10830.0 11010.2 11107.8 10789.4 10952.4 11004.2 11157.8 11241.1 6549.9 10523.0 10686.5 11037.8 11167.9 7959.4 8006.1 8010.4 8065.2 8194.8 8559.0 10527.3 10789.9 10970.2 10992.2 02:43:35 INFO - PROCESS | 14592 | 02:43:35 INFO - PROCESS | 14592 | [#3] mootools.html Cycles:180 Average:5566.11 Median:6572.04 stddev:2930.98 (44.6%) stddev-sans-first:2922.18 02:43:35 INFO - PROCESS | 14592 | Values: 1364.4 1482.6 1513.4 1697.0 1873.1 7539.9 7756.8 7761.4 7769.9 7777.5 7595.5 7757.6 7778.8 7782.0 7782.3 1990.0 2255.3 2280.8 2286.4 2352.7 2334.0 2339.5 2341.1 2341.6 2342.8 2240.8 2288.7 2290.2 2290.5 2290.7 2248.7 2269.3 2352.9 2353.4 2354.5 2305.4 2315.9 2330.6 2331.3 2332.5 7890.3 8049.6 8073.2 8079.2 8088.0 4839.3 4961.2 4971.5 5007.1 5016.1 3027.6 3118.1 3157.1 3177.7 3198.7 920.5 925.5 935.0 947.4 953.2 11155.6 11177.5 11214.9 11238.6 11252.6 4423.0 4549.2 4610.7 4619.5 4626.6 9437.7 9462.9 9479.7 9494.4 9502.5 4433.4 5010.0 5038.9 5040.6 5044.1 4239.8 4277.5 4312.1 4357.0 4374.4 3722.3 3785.6 3794.3 3815.9 3841.1 1202.2 1205.8 1212.1 1222.7 1226.1 1329.7 1379.8 1380.0 1388.9 1398.9 7456.9 7512.8 7571.3 7602.5 7610.5 490.3 491.5 498.0 498.0 508.2 5780.2 5795.4 5818.5 5870.0 5873.0 9231.9 9886.2 10008.0 10010.3 10031.0 9724.5 9776.4 9776.5 9788.2 9794.7 7407.1 7611.7 7618.8 7630.7 7724.5 7241.2 7270.0 7272.6 7318.5 7358.4 8422.4 8700.0 8724.1 8736.7 8821.1 8480.5 8610.8 8643.3 8747.2 8834.4 6049.2 6657.8 6784.6 6792.9 6928.3 7541.0 7572.7 7581.2 7615.4 7630.5 6691.7 6822.4 6841.2 6968.5 7000.6 6724.3 6781.0 6838.1 6931.1 6951.7 6869.8 7071.2 7106.6 7114.1 7115.6 6564.9 6579.1 6600.9 6607.2 6620.6 6483.4 6627.4 6630.4 6651.6 6667.1 02:43:35 INFO - PROCESS | 14592 | 02:43:35 INFO - PROCESS | 14592 | [#4] prototype.html Cycles:180 Average:5170.02 Median:5928.82 stddev:1580.69 (26.7%) stddev-sans-first:1542.79 02:43:35 INFO - PROCESS | 14592 | Values: 328.4 328.9 330.1 331.3 337.2 5800.0 5807.7 5823.5 5874.9 5884.2 5799.2 5801.6 5805.2 5820.3 5826.7 4294.6 4382.1 4467.4 4478.2 4482.2 4467.0 4480.1 4498.1 4502.3 4504.4 4266.7 4454.3 4457.6 4460.8 4464.9 4319.3 4350.9 4351.7 4381.3 4391.1 3808.9 3838.1 3845.5 3851.2 3857.5 5528.9 5539.6 5556.7 5557.6 5560.0 5105.4 5118.4 5127.8 5131.1 5133.4 6074.9 6087.1 6109.3 6122.2 6123.2 4152.1 4198.5 4238.3 4238.5 4242.2 6358.6 6371.6 6385.4 6388.5 6398.9 4302.4 4330.6 4332.5 4334.6 4336.7 4391.5 4391.7 4394.2 4394.9 4395.4 5091.9 5095.6 5095.6 5097.6 5099.4 5982.7 6184.8 6192.8 6194.9 6195.3 1520.8 1530.7 1538.2 1539.8 1542.1 952.6 993.3 1019.2 1022.7 1036.4 5841.3 5923.9 5933.7 5988.4 5989.6 6377.4 6388.2 6389.0 6440.8 6452.9 5966.3 5968.0 5970.3 5970.6 5975.2 3399.9 3428.3 3430.0 3431.7 3433.0 6525.2 6697.6 6713.7 6724.3 6732.0 6516.7 6517.7 6531.0 6531.4 6534.2 6689.2 6692.5 6693.3 6694.3 6696.2 6361.3 6367.3 6370.1 6372.1 6372.2 6146.8 6303.5 6310.1 6311.6 6312.7 6715.4 6740.8 6748.0 6753.5 6754.5 4299.8 4343.2 4344.0 4350.7 4351.6 6380.6 6408.0 6422.5 6426.0 6440.9 6244.9 6245.7 6298.9 6312.0 6321.6 6015.8 6198.3 6241.7 6250.3 6251.6 6112.7 6120.1 6134.7 6139.8 6145.2 6268.5 6269.2 6270.8 6275.9 6277.4 5862.0 6124.0 6126.6 6132.3 6133.4 02:43:35 INFO - PROCESS | 14592 | 02:43:35 INFO - PROCESS | 14592 | [#5] yui.html Cycles:180 Average:13580.68 Median:24300.60 stddev:15343.70 (63.1%) stddev-sans-first:15356.45 02:43:35 INFO - PROCESS | 14592 | Values: 742.0 786.5 821.2 839.6 861.2 13748.2 14017.1 14072.6 14088.2 14088.3 12265.3 12440.6 12464.3 12517.0 12522.9 826.0 840.3 842.0 843.5 844.3 830.8 832.7 838.0 838.2 838.4 874.9 875.1 877.5 878.4 879.3 871.0 871.7 871.7 872.0 874.1 644.1 645.0 645.2 646.6 646.7 12796.0 12863.5 12873.5 12882.7 12906.4 11471.9 11863.4 12035.0 12108.0 12211.5 10805.0 11499.5 11612.9 11698.4 12000.8 3586.6 3613.4 3651.4 3722.5 3724.5 46687.5 46944.8 46956.0 47021.5 51616.5 8284.8 10156.7 10249.7 10367.1 10685.9 17102.5 17185.2 17250.5 17266.2 17268.6 6718.4 6805.2 6822.1 6836.6 7343.0 4109.7 4161.7 4162.1 4259.4 4445.9 3151.8 3177.5 3183.0 3192.7 3199.9 605.2 610.7 618.1 619.5 624.0 632.3 659.4 659.9 661.5 679.6 8355.0 8688.8 8774.3 8784.8 8827.3 479.5 597.3 623.7 644.5 665.4 4060.7 4151.9 4178.5 4233.2 4261.6 51937.2 53987.0 54099.0 54278.7 54587.7 47383.5 48518.8 48612.0 48665.3 48804.5 39991.6 42558.8 44500.0 49136.0 49868.8 8952.5 9068.8 9081.0 9129.5 9300.1 33925.8 34652.0 34951.0 35403.0 35507.5 42576.0 43795.1 44021.6 44155.3 44586.0 10769.3 10890.5 11313.9 11332.5 11429.2 12505.7 12541.7 12762.6 12804.7 12911.5 11124.7 11306.2 11387.8 11747.8 12178.6 11197.9 11201.5 11883.7 12149.9 12154.3 11448.5 11710.5 11716.8 11976.2 12037.9 9240.2 9418.3 9464.6 9542.7 9733.1 9584.7 9755.8 9984.6 10160.1 10262.2 02:43:35 INFO - PROCESS | 14592 | -------- Summary: end -------- 02:43:35 INFO - PROCESS | 14592 | 02:43:36 INFO - TEST-INFO | 14592: exit 0 02:43:36 INFO - TEST-OK | dromaeo_css | took 1113787ms 02:43:36 INFO - TEST-START | kraken 02:43:36 INFO - operating with platform_type : linux_ 02:43:36 INFO - Initialising browser for kraken test... 02:43:36 INFO - TEST-INFO | started process 14782 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLO52Tf/profile http://localhost:47156/getInfo.html) 02:43:40 INFO - PROCESS | 14782 | __metrics Screen width/height:1600/1200 02:43:40 INFO - PROCESS | 14782 | colorDepth:24 02:43:40 INFO - PROCESS | 14782 | Browser inner width/height: 1024/697 02:43:40 INFO - PROCESS | 14782 | __metrics 02:43:41 INFO - PROCESS | 14782 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:43:42 INFO - TEST-INFO | 14782: exit 0 02:43:42 INFO - Browser initialized. 02:43:42 INFO - Running cycle 1/1 for kraken test... 02:43:42 INFO - TEST-INFO | started process 14868 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLO52Tf/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:43:54 INFO - PROCESS | 14868 | RSS: Main: 153853952 02:43:54 INFO - PROCESS | 14868 | 02:43:56 INFO - PROCESS | 14868 | Cycle 1(1): loaded http://localhost:47156/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47156/tests/kraken/driver.html?testName=audio-beat-detection) 02:43:57 INFO - PROCESS | 14868 | RSS: Main: 198221824 02:43:57 INFO - PROCESS | 14868 | 02:44:00 INFO - PROCESS | 14868 | Cycle 1(1): loaded http://localhost:47156/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47156/tests/kraken/driver.html?testName=audio-dft) 02:44:00 INFO - PROCESS | 14868 | RSS: Main: 188571648 02:44:00 INFO - PROCESS | 14868 | 02:44:03 INFO - PROCESS | 14868 | Cycle 1(1): loaded http://localhost:47156/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47156/tests/kraken/driver.html?testName=audio-fft) 02:44:04 INFO - PROCESS | 14868 | RSS: Main: 171909120 02:44:04 INFO - PROCESS | 14868 | 02:44:06 INFO - PROCESS | 14868 | Cycle 1(1): loaded http://localhost:47156/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47156/tests/kraken/driver.html?testName=audio-oscillator) 02:44:06 INFO - PROCESS | 14868 | RSS: Main: 172621824 02:44:06 INFO - PROCESS | 14868 | 02:44:09 INFO - PROCESS | 14868 | Cycle 1(1): loaded http://localhost:47156/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47156/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:44:09 INFO - PROCESS | 14868 | RSS: Main: 174075904 02:44:09 INFO - PROCESS | 14868 | 02:44:12 INFO - PROCESS | 14868 | Cycle 1(1): loaded http://localhost:47156/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47156/tests/kraken/driver.html?testName=imaging-darkroom) 02:44:13 INFO - PROCESS | 14868 | RSS: Main: 175742976 02:44:13 INFO - PROCESS | 14868 | 02:44:16 INFO - PROCESS | 14868 | Cycle 1(1): loaded http://localhost:47156/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47156/tests/kraken/driver.html?testName=imaging-desaturate) 02:44:17 INFO - PROCESS | 14868 | RSS: Main: 176041984 02:44:17 INFO - PROCESS | 14868 | 02:44:19 INFO - PROCESS | 14868 | Cycle 1(1): loaded http://localhost:47156/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47156/tests/kraken/driver.html?testName=json-parse-financial) 02:44:20 INFO - PROCESS | 14868 | RSS: Main: 175194112 02:44:20 INFO - PROCESS | 14868 | 02:44:22 INFO - PROCESS | 14868 | Cycle 1(1): loaded http://localhost:47156/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47156/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:44:22 INFO - PROCESS | 14868 | RSS: Main: 189620224 02:44:22 INFO - PROCESS | 14868 | 02:44:24 INFO - PROCESS | 14868 | Cycle 1(1): loaded http://localhost:47156/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47156/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:44:25 INFO - PROCESS | 14868 | RSS: Main: 184815616 02:44:25 INFO - PROCESS | 14868 | 02:44:27 INFO - PROCESS | 14868 | Cycle 1(1): loaded http://localhost:47156/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47156/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:44:27 INFO - PROCESS | 14868 | RSS: Main: 195317760 02:44:27 INFO - PROCESS | 14868 | 02:44:30 INFO - PROCESS | 14868 | Cycle 1(1): loaded http://localhost:47156/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47156/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:44:30 INFO - PROCESS | 14868 | RSS: Main: 200380416 02:44:30 INFO - PROCESS | 14868 | 02:44:33 INFO - PROCESS | 14868 | Cycle 1(1): loaded http://localhost:47156/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47156/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:44:33 INFO - PROCESS | 14868 | RSS: Main: 202588160 02:44:33 INFO - PROCESS | 14868 | 02:44:35 INFO - PROCESS | 14868 | Cycle 1(1): loaded http://localhost:47156/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47156/tests/kraken/driver.html?testName=ai-astar) 02:44:35 INFO - PROCESS | 14868 | RSS: Main: 261505024 02:44:35 INFO - PROCESS | 14868 | 02:44:35 INFO - PROCESS | 14868 | __start_tp_report 02:44:35 INFO - PROCESS | 14868 | _x_x_mozilla_page_load 02:44:35 INFO - PROCESS | 14868 | _x_x_mozilla_page_load_details 02:44:35 INFO - PROCESS | 14868 | |i|pagename|runs| 02:44:35 INFO - PROCESS | 14868 | |0;ai-astar;109;110;105;109;111;113;99;111;109;110 02:44:35 INFO - PROCESS | 14868 | |1;audio-beat-detection;148;127;155;171;127;154;150;127;172;126 02:44:35 INFO - PROCESS | 14868 | |2;audio-dft;161;162;160;163;161;161;162;161;161;162 02:44:35 INFO - PROCESS | 14868 | |3;audio-fft;76;75;93;96;76;76;73;121;117;76 02:44:35 INFO - PROCESS | 14868 | |4;audio-oscillator;94;93;142;93;93;94;134;92;93;144 02:44:35 INFO - PROCESS | 14868 | |5;imaging-gaussian-blur;116;117;117;117;117;118;116;117;117;117 02:44:35 INFO - PROCESS | 14868 | |6;imaging-darkroom;146;145;146;146;146;146;146;147;145;145 02:44:35 INFO - PROCESS | 14868 | |7;imaging-desaturate;96;95;96;95;96;96;95;95;96;96 02:44:35 INFO - PROCESS | 14868 | |8;json-parse-financial;58;57;59;57;60;57;58;67;57;57 02:44:35 INFO - PROCESS | 14868 | |9;json-stringify-tinderbox;66;68;68;68;68;68;67;67;67;70 02:44:35 INFO - PROCESS | 14868 | |10;stanford-crypto-aes;80;88;83;83;82;81;82;81;88;83 02:44:35 INFO - PROCESS | 14868 | |11;stanford-crypto-ccm;124;119;115;116;117;119;124;115;114;117 02:44:35 INFO - PROCESS | 14868 | |12;stanford-crypto-pbkdf2;150;148;147;148;150;147;151;149;154;161 02:44:35 INFO - PROCESS | 14868 | |13;stanford-crypto-sha256-iterative;67;67;70;70;72;66;72;68;72;67 02:44:35 INFO - PROCESS | 14868 | __end_tp_report 02:44:35 INFO - PROCESS | 14868 | __start_cc_report 02:44:35 INFO - PROCESS | 14868 | _x_x_mozilla_cycle_collect,1068 02:44:35 INFO - PROCESS | 14868 | __end_cc_report 02:44:35 INFO - PROCESS | 14868 | __startTimestamp1457433875916__endTimestamp 02:44:35 INFO - PROCESS | 14868 | 02:44:35 INFO - PROCESS | 14868 | ------- Summary: start ------- 02:44:35 INFO - PROCESS | 14868 | Number of tests: 14 02:44:35 INFO - PROCESS | 14868 | 02:44:35 INFO - PROCESS | 14868 | [#0] ai-astar Cycles:10 Average:108.60 Median:110.50 stddev:3.95 (3.6%) stddev-sans-first:4.19 02:44:35 INFO - PROCESS | 14868 | Values: 109.0 110.0 105.0 109.0 111.0 113.0 99.0 111.0 109.0 110.0 02:44:35 INFO - PROCESS | 14868 | 02:44:35 INFO - PROCESS | 14868 | [#1] audio-beat-detection Cycles:10 Average:145.70 Median:152.00 stddev:18.10 (11.9%) stddev-sans-first:19.18 02:44:35 INFO - PROCESS | 14868 | Values: 148.0 127.0 155.0 171.0 127.0 154.0 150.0 127.0 172.0 126.0 02:44:35 INFO - PROCESS | 14868 | 02:44:35 INFO - PROCESS | 14868 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:0.84 (0.5%) stddev-sans-first:0.88 02:44:35 INFO - PROCESS | 14868 | Values: 161.0 162.0 160.0 163.0 161.0 161.0 162.0 161.0 161.0 162.0 02:44:35 INFO - PROCESS | 14868 | 02:44:35 INFO - PROCESS | 14868 | [#3] audio-fft Cycles:10 Average:87.90 Median:76.00 stddev:18.22 (24.0%) stddev-sans-first:18.81 02:44:35 INFO - PROCESS | 14868 | Values: 76.0 75.0 93.0 96.0 76.0 76.0 73.0 121.0 117.0 76.0 02:44:35 INFO - PROCESS | 14868 | 02:44:35 INFO - PROCESS | 14868 | [#4] audio-oscillator Cycles:10 Average:107.20 Median:93.00 stddev:22.78 (24.5%) stddev-sans-first:23.65 02:44:35 INFO - PROCESS | 14868 | Values: 94.0 93.0 142.0 93.0 93.0 94.0 134.0 92.0 93.0 144.0 02:44:35 INFO - PROCESS | 14868 | 02:44:35 INFO - PROCESS | 14868 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 02:44:35 INFO - PROCESS | 14868 | Values: 116.0 117.0 117.0 117.0 117.0 118.0 116.0 117.0 117.0 117.0 02:44:35 INFO - PROCESS | 14868 | 02:44:35 INFO - PROCESS | 14868 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 02:44:35 INFO - PROCESS | 14868 | Values: 146.0 145.0 146.0 146.0 146.0 146.0 146.0 147.0 145.0 145.0 02:44:35 INFO - PROCESS | 14868 | 02:44:35 INFO - PROCESS | 14868 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 02:44:35 INFO - PROCESS | 14868 | Values: 96.0 95.0 96.0 95.0 96.0 96.0 95.0 95.0 96.0 96.0 02:44:35 INFO - PROCESS | 14868 | 02:44:35 INFO - PROCESS | 14868 | [#8] json-parse-financial Cycles:10 Average:58.70 Median:58.00 stddev:3.09 (5.3%) stddev-sans-first:3.27 02:44:35 INFO - PROCESS | 14868 | Values: 58.0 57.0 59.0 57.0 60.0 57.0 58.0 67.0 57.0 57.0 02:44:35 INFO - PROCESS | 14868 | 02:44:35 INFO - PROCESS | 14868 | [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:68.00 stddev:1.06 (1.6%) stddev-sans-first:0.93 02:44:35 INFO - PROCESS | 14868 | Values: 66.0 68.0 68.0 68.0 68.0 68.0 67.0 67.0 67.0 70.0 02:44:35 INFO - PROCESS | 14868 | 02:44:35 INFO - PROCESS | 14868 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:83.00 stddev:2.77 (3.3%) stddev-sans-first:2.70 02:44:35 INFO - PROCESS | 14868 | Values: 80.0 88.0 83.0 83.0 82.0 81.0 82.0 81.0 88.0 83.0 02:44:35 INFO - PROCESS | 14868 | 02:44:35 INFO - PROCESS | 14868 | [#11] stanford-crypto-ccm Cycles:10 Average:118.00 Median:118.00 stddev:3.56 (3.0%) stddev-sans-first:3.04 02:44:35 INFO - PROCESS | 14868 | Values: 124.0 119.0 115.0 116.0 117.0 119.0 124.0 115.0 114.0 117.0 02:44:35 INFO - PROCESS | 14868 | 02:44:35 INFO - PROCESS | 14868 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.50 Median:150.00 stddev:4.25 (2.8%) stddev-sans-first:4.50 02:44:35 INFO - PROCESS | 14868 | Values: 150.0 148.0 147.0 148.0 150.0 147.0 151.0 149.0 154.0 161.0 02:44:35 INFO - PROCESS | 14868 | 02:44:35 INFO - PROCESS | 14868 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:70.00 stddev:2.38 (3.4%) stddev-sans-first:2.40 02:44:35 INFO - PROCESS | 14868 | Values: 67.0 67.0 70.0 70.0 72.0 66.0 72.0 68.0 72.0 67.0 02:44:35 INFO - PROCESS | 14868 | -------- Summary: end -------- 02:44:35 INFO - PROCESS | 14868 | 02:44:36 INFO - TEST-INFO | 14868: exit 0 02:44:36 INFO - TEST-OK | kraken | took 60364ms 02:44:36 INFO - SUITE-END | took 1174s 02:44:37 INFO - Completed test suite (00:19:34) 02:44:37 INFO - javascript benchmark 02:44:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3085.706857848504, 3160.9051728448153, 3197.0, 3202.1514298710845, 3229.208843833261, 5061.0, 5076.5684916782075, 5106.795728170878, 5133.48665133487, 5139.640225184238, 5071.2139618359215, 5072.365954255718, 5074.568661663754, 5094.388673359193, 5159.767810448529, 4640.2343613303765, 4665.183592871243, 4711.575958163765, 4752.691075080109, 4780.737059461728, 4603.263477843546, 4656.7205967641885, 4733.59764420023, 4759.547842954914, 4860.756962151896, 4605.815767369301, 4617.561331673485, 4622.306654001893, 4637.768111594407, 4687.92968105477, 4623.0984957933215, 4635.374224479686, 4635.930461043087, 4638.234691275936, 4645.256758918556, 4547.545245475426, 4604.401427814396, 4605.37827393301, 4617.930731039037, 4711.575958163748, 5007.949920500785, 5019.824306149268, 5020.196768517057, 5067.6452648314635, 5085.720285384303, 5570.387257401682, 5571.387147413781, 5573.136163894603, 5584.190292407578, 5633.40849210831, 5425.104857698515, 5567.554595632339, 5589.273394458735, 5611.130274807411, 5628.296462942132, 5153.793848246066, 5168.328117344721, 5176.534111929906, 5227.163653815372, 5235.450277720823, 5662.405447427961, 5663.886722265532, 5665.951798917214, 5669.007923613433, 5669.206311116447, 5313.1764576490705, 5317.973410133002, 5323.574114070865, 5361.142217245222, 5388.46115388458, 5558.166275058774, 5586.441355864381, 5595.188697638901, 5598.524125449301, 5611.859703507445, 5400.378956420062, 5498.120300751941, 5561.140695764727, 5561.360443548962, 5605.103183490622, 5376.193570964387, 5410.0, 5415.350157981067, 5443.836684899459, 5464.153056276284, 4135.29699951009, 4136.084060737173, 4145.585441455891, 4148.253314403436, 4172.123853990635, 3733.2720119576966, 3742.5321834770652, 3798.031501967036, 3803.82882770276, 3803.847846086181, 5240.449752775904, 5240.475952404805, 5260.079486089995, 5267.078261304257, 5317.468253174651, 5527.060399732055, 5573.832785016456, 5579.414161513064, 5584.190292407578, 5628.915566266509, 4960.553550180501, 5001.924971125436, 5111.028904508132, 5206.843794686166, 5276.841694749087, 4640.883977900512, 4651.930221046687, 4659.347691323217, 4696.131215725101, 4712.081144176921, 5744.454276843693, 5746.339170995306, 5749.080147176432, 5749.1663708762, 5757.4242575741255, 5362.812301569426, 5418.295621569171, 5442.319710036246, 5493.0, 5527.917081243704, 5736.913946290892, 5751.712414379348, 5755.309362876482, 5755.482006619257, 5759.136129580596, 5440.863978400572, 5448.291722076105, 5456.48163424474, 5458.4814442627885, 5463.153211252262, 5271.604629652715, 5299.788008479618, 5321.3880403754065, 5380.650257733235, 5535.667859928417, 5372.946270537401, 5374.11327131019, 5376.301080859464, 5381.461853814587, 5388.245645609696, 5383.380911195262, 5385.4076051635075, 5387.299651045339, 5390.541803946709, 5431.9728401359325, 5201.271821944855, 5348.197770334481, 5374.0, 5376.435474275145, 5431.538319242909, 5364.678119312854, 5375.00562395958, 5398.62209645321, 5404.459554044722, 5455.918161227505, 5169.4830516948, 5271.8682032947945, 5296.2055691646565, 5297.629165958346, 5298.8940221196135], "unit": "score", "name": "dojo.html", "value": 5076.223976898825}, {"lowerIsBetter": false, "replicates": [488.8899997500563, 523.3667262612239, 531.1793279383352, 545.5281181777762, 605.4520658803784, 28955.710442895564, 29677.703222967764, 37764.24471510571, 38150.618493815055, 38303.808480957625, 40918.0, 41013.794931025375, 41309.17381652365, 41528.96177595561, 41753.79123104388, 7408.666610002563, 8490.235878770925, 8733.868991965126, 8741.0, 8745.125487451267, 7522.774316770506, 7639.809004774869, 10395.74010649736, 10600.681979540626, 10603.257771955927, 10336.069753722164, 10422.114120299784, 10424.166066714683, 10426.270161088727, 10431.217658675592, 10154.187664986783, 10163.288569800117, 10265.538050787733, 10266.0, 10270.845937310947, 10149.797004059952, 10243.692689219335, 10265.640702575449, 10287.845682314772, 10291.639792607297, 38203.23593528114, 38716.22567548662, 42480.57519424828, 42492.36261456081, 42548.36177457341, 3354.2285274387027, 3392.9321413571593, 3522.7005704515145, 3592.8742494012586, 3775.5091838061153, 30812.628730062548, 31442.21394465134, 31865.84067079673, 31873.0, 33649.83175084133, 3623.691986181178, 3625.7099432045375, 3695.3533131701843, 3700.9444858327147, 3718.851245950159, 275999.0, 277068.99999999796, 278555.0, 278682.0, 278791.0, 44607.55392446034, 61877.690611546655, 62287.68856155781, 62362.68818655878, 62477.687611561654, 44334.55665443304, 44540.0, 44629.77685111554, 44632.0, 44675.55324446779, 15389.461368852037, 15537.68924621524, 15617.531474055797, 15631.140287284308, 15636.0, 10149.949250253701, 12499.312537810507, 12656.81014784779, 12675.669054749304, 12681.873181268254, 14403.711925761427, 14537.563873083824, 14556.344964476411, 14592.927035364755, 14599.197044162673, 5505.119180931112, 5603.691796951207, 5673.858153546194, 5676.545876329967, 5683.147527870769, 831.667333066766, 896.9372143949861, 929.5352323838081, 971.4608392342318, 1029.629333439961, 26805.86597067002, 28335.858320708263, 29487.26281842971, 29744.321583968464, 30127.0, 1060.8461773042866, 1063.1813503602339, 1084.38732116354, 1168.485866218861, 1188.5958774016876, 14984.325705343286, 15556.377744890078, 15572.84427155714, 15655.217239137997, 15819.762703559456, 302833.0, 303528.0, 305234.0, 306314.0, 306917.0, 54601.45398546043, 55426.0, 55459.445405546234, 55471.0, 55515.0, 1166.3701601135463, 1339.9933000334936, 1344.677277453404, 1358.5041459867275, 1361.9931900340632, 26984.730152698223, 29687.25781855471, 29837.254068648457, 30042.69957300399, 30049.399012020076, 41111.0, 42016.0, 42079.0, 42083.36874946817, 42593.57406425896, 180440.0, 183099.0, 184703.0, 191384.0, 195194.0, 27306.45387092287, 31720.36559268848, 31929.521057183698, 32766.344673105927, 32866.67133328636, 38948.80525597467, 42625.36061959011, 43061.56938430575, 43542.56457435385, 44012.779936100116, 35268.82365588258, 35737.821310893276, 35894.28211435809, 36024.27951440904, 36500.0, 36100.0, 36145.0, 36274.455883161245, 36472.27055458929, 36485.0, 33987.0, 36665.45001825028, 36792.0, 37142.44286335653, 37146.44280335743, 31305.0, 35553.28893422169, 38100.237995240495, 39068.0, 39649.40525892172, 24196.87901560481, 24244.151454699, 24253.151139710026, 24567.50864982726, 24802.50394992054], "unit": "score", "name": "ext.html", "value": 18043.589873085464}, {"lowerIsBetter": false, "replicates": [307.84607696151926, 338.700200948953, 351.7063252184426, 352.36398301066566, 370.1191165027235, 16797.916010419947, 17359.132043397825, 17731.379401720926, 18254.0, 18289.817101829012, 10900.672979810599, 11445.656630301084, 16834.24245908934, 16902.83097169028, 16914.407995720154, 4956.653034287592, 5129.0, 5156.664816786915, 5189.299444574991, 5598.580106492009, 5486.204500347447, 5489.011977843987, 5567.109262517998, 5576.693281869496, 5579.0, 5516.14499752539, 5518.889622207554, 5531.2809334786425, 5532.640378375413, 5598.804041858536, 5772.191893134965, 5775.306963164405, 5796.942030579682, 5801.941980580204, 5807.2160258365, 4985.626078044161, 5153.768080436389, 5165.9225111623355, 5209.947900520984, 5213.244079608436, 13079.28063956482, 13143.0, 13486.595402137853, 20166.899165504226, 20395.89802050995, 2211.0934516848174, 2302.5625131225183, 2331.440454290958, 2485.2792690119845, 2493.9376515587073, 9038.593263303168, 9198.770030749218, 9213.953930230373, 9222.953885230598, 9612.327137100407, 1860.6185731924922, 1878.8121187881238, 1890.5273681579606, 1911.7705875294914, 1933.4006457997925, 62347.0, 63860.3613963859, 64090.35909640891, 64641.03038454427, 65293.673531632514, 9581.856272155923, 9757.316987810927, 10207.948960255151, 10247.231457640706, 10410.219233557513, 13577.253251071088, 13660.65848353799, 13668.0, 13710.794338084937, 13717.245551494763, 7597.696092156362, 7665.808354791064, 7740.0, 7777.883331750028, 7822.765317040498, 7608.619569021526, 7613.505122167041, 7694.499857509244, 7728.304452599293, 7738.806529836799, 4492.483364413069, 4531.932021019687, 4578.610818080434, 4619.145458090197, 4636.211843986531, 1701.6936951348628, 1793.6950718377907, 1795.9281628734966, 1813.9909300453678, 1814.4738025972583, 885.2873436883242, 886.1094599927033, 900.7567956651667, 914.7347269291964, 964.4165280005636, 15092.54722358331, 15557.688846223013, 16408.26162822676, 16752.0, 16929.83070169307, 839.2404873589411, 878.3675753457501, 921.5944984206927, 940.6049459227141, 1035.3115178406276, 9459.952700236592, 9771.755706107404, 9780.0, 9832.9016709832, 9941.900580994097, 336815.0, 345731.0, 441774.0, 446571.0, 447670.0, 67485.32514674889, 67619.66190169018, 68641.65679171572, 73084.63457682784, 74561.62719186369, 878.508035500122, 890.512843551271, 904.6788390121412, 906.392716879679, 999.5102399824034, 14460.27698615086, 15396.769048464057, 15529.611759706098, 15581.532554023397, 15836.60408489797, 33584.16039599029, 33606.159846003065, 33828.83085584556, 34319.0, 34350.0, 44726.552734472236, 45332.54667453283, 45676.0, 45770.771146144056, 45940.54059459496, 7967.28294453502, 7974.322182614543, 8104.27061564462, 8300.87548686758, 8328.458650187718, 6668.566543174678, 9798.65704700332, 10562.260641755003, 12513.0, 12559.246445213317, 10604.0, 10670.679879603624, 10830.0, 11010.229283950366, 11107.833382499108, 10789.352638841694, 10952.397618131079, 11004.229703920648, 11157.832632510681, 11241.100711942861, 6549.934500655123, 10523.0, 10686.465676715978, 11037.779244415227, 11167.888321116685, 7959.4030447715495, 8006.079300880473, 8010.399220058635, 8065.1934806518875, 8194.754157375288, 8559.0, 10527.315724477885, 10789.946050270013, 10970.177236707119, 10992.230543861853], "unit": "score", "name": "jquery.html", "value": 8211.596704788852}, {"lowerIsBetter": false, "replicates": [1364.3655700099453, 1482.5700546841417, 1513.447591629055, 1696.9575760605983, 1873.1289950173175, 7539.886901696472, 7756.767296981093, 7761.379089672812, 7769.922300776991, 7777.533347999117, 7595.4683172177965, 7757.573333466671, 7778.766637000899, 7782.0, 7782.260685234908, 1990.0, 2255.3459496745922, 2280.7605201453857, 2286.3941055620276, 2352.741198468167, 2334.0313769785603, 2339.532093581282, 2341.098677009355, 2341.5785158671433, 2342.847714898535, 2240.831937604678, 2288.7253529576474, 2290.209877592228, 2290.473191166033, 2290.6564015397657, 2248.685184074231, 2269.2511471214543, 2352.882355882199, 2353.423411264234, 2354.505553833697, 2305.3660243433023, 2315.895784689676, 2330.568844763724, 2331.2889568681544, 2332.5101728637005, 7890.289873911375, 8049.557274349967, 8073.233042860918, 8079.232472915063, 8088.029436467603, 4839.298301746262, 4961.206207006898, 4971.45314015458, 5007.098722229997, 5016.072026675077, 3027.6366835979825, 3118.1269244611544, 3157.068664743906, 3177.698118678722, 3198.6641402652854, 920.5489310238003, 925.4724806860092, 934.9672761453317, 947.3652652722692, 953.208836665566, 11155.609553665663, 11177.49701263445, 11214.887851121466, 11238.606648767254, 11252.606158784403, 4423.0, 4549.181147393435, 4610.74640894754, 4619.538046195421, 4626.6298696104905, 9437.716868493957, 9462.905370946202, 9479.715608531755, 9494.430334179833, 9502.524873756423, 4433.401490798766, 5010.048090862724, 5038.949610503922, 5040.647154699136, 5044.142495775727, 4239.8092085856215, 4277.529471758104, 4312.05134870328, 4357.0, 4374.409454723572, 3722.3485889969147, 3785.621437856247, 3794.29805485986, 3815.923681526354, 3841.1357444574746, 1202.2065436811663, 1205.764875849201, 1212.0545974140184, 1222.7004383925816, 1226.1294480918468, 1329.7407005633809, 1379.8206233189621, 1380.0, 1388.9444422222998, 1398.8741013308852, 7456.925430745623, 7512.849743005109, 7571.318581327597, 7602.543847369065, 7610.543367397974, 490.3478373762887, 491.4913064977802, 497.9751012449363, 498.006477078224, 508.19451169895393, 5780.248567686258, 5795.420457954171, 5818.5345172386105, 5869.970650146807, 5873.0, 9231.861522077174, 9886.209103271722, 10008.049235322633, 10010.349327293703, 10031.047050530187, 9724.465154416434, 9776.364536305118, 9776.462294573725, 9788.168005719452, 9794.65718699842, 7407.148177959496, 7611.733589324347, 7618.847623047619, 7630.656620452093, 7724.497907636098, 7241.239669834592, 7270.018547496232, 7272.5636461810345, 7318.451116166202, 7358.411327093712, 8422.368322375723, 8699.956500217459, 8724.083971182934, 8736.650533978824, 8821.073787252246, 8480.533570653673, 8610.827783444422, 8643.308535317285, 8747.212750852454, 8834.381593288408, 6049.153118563317, 6657.833554161185, 6784.626845523544, 6792.898106528505, 6928.307169283032, 7541.0, 7572.659230334538, 7581.166071732216, 7615.352695020763, 7630.504017238862, 6691.698873550605, 6822.420094292041, 6841.247462778991, 6968.547044442095, 7000.649967501503, 6724.29394913527, 6781.0, 6838.076859623887, 6931.064306318583, 6951.721931122698, 6869.828254293682, 7071.186813516511, 7106.609136497542, 7114.075170227838, 7115.6086415247655, 6564.934350656432, 6579.144711187515, 6600.900986485302, 6607.174103237096, 6620.569662971891, 6483.4164925156965, 6627.370399812203, 6630.403263706289, 6651.63416012124, 6667.066610674412], "unit": "score", "name": "mootools.html", "value": 4487.299065772633}, {"lowerIsBetter": false, "replicates": [328.4334522947914, 328.88160262305564, 330.14821759859564, 331.2893842707393, 337.1907422186752, 5800.0, 5807.709614519273, 5823.475887170154, 5874.853128671785, 5884.176215329847, 5799.217105690731, 5801.564882633809, 5805.24531810865, 5820.330661973874, 5826.737796799143, 4294.570542945712, 4382.057857560624, 4467.352233926079, 4478.23869942109, 4482.238019536687, 4467.039586488904, 4480.148771733377, 4498.077894031732, 4502.279635258359, 4504.436945381827, 4266.658667306608, 4454.309582014793, 4457.621102206316, 4460.754658493782, 4464.933026004596, 4319.308910574325, 4350.8912277193, 4351.6953813233085, 4381.255186618282, 4391.143726973241, 3808.8666896658483, 3838.136419305662, 3845.5000849889616, 3851.2490064437447, 3857.498525191735, 5528.889422211573, 5539.612227144102, 5556.666600003972, 5557.5553955683445, 5560.026995275851, 5105.412877519096, 5118.436971933084, 5127.7948882044675, 5131.050755610224, 5133.358330208724, 6074.908876366858, 6087.05650624154, 6109.266887973472, 6122.204113465221, 6123.2039834821635, 4152.065785198336, 4198.517170525398, 4238.279492486254, 4238.491381034265, 4242.151569686044, 6358.554901156921, 6371.553991220617, 6385.361463853577, 6388.488920886364, 6398.9040164397575, 4302.419173411612, 4330.566943305645, 4332.523422423531, 4334.566543345703, 4336.674749393808, 4391.538888416734, 4391.692581519327, 4394.209042372404, 4394.934075988863, 4395.384646149541, 5091.8981620367385, 5095.617828662865, 5095.617828662865, 5097.592192624581, 5099.36257967754, 5982.700864956735, 6184.783532576428, 6192.81421557354, 6194.946859033975, 6195.287541932646, 1520.7642815363636, 1530.732121878689, 1538.2001359293106, 1539.7767323737996, 1542.1441100189502, 952.6094301336419, 993.294760719897, 1019.1541020952592, 1022.7443139215196, 1036.3988886445843, 5841.299044114733, 5923.911141332884, 5933.732982015819, 5988.431099045583, 5989.610675306091, 6377.426031657174, 6388.169537960035, 6388.968055159788, 6440.774572889926, 6452.870942581122, 5966.31387390447, 5968.0, 5970.253718285215, 5970.641761494324, 5975.223220981332, 3399.932001359959, 3428.3143371325837, 3429.9828500857334, 3431.673990970854, 3433.038749150242, 6525.249596296487, 6697.598144111369, 6713.731450741916, 6724.260331363546, 6731.966340168366, 6516.706748196342, 6517.706703198272, 6531.0, 6531.444827189647, 6534.183227096613, 6689.2307384651385, 6692.498062645321, 6693.330666933365, 6694.297098804555, 6696.229933557605, 6361.268454127649, 6367.299597044229, 6370.140031095742, 6372.139761132374, 6372.235331760218, 6146.754129834935, 6303.527235457267, 6310.085037669604, 6311.621302721851, 6312.684365781784, 6715.3620406061345, 6740.831479213059, 6747.966260168668, 6753.459723222229, 6754.493412994143, 4299.849505267301, 4343.19650864591, 4344.0, 4350.651947844101, 4351.608355248043, 6380.553361264667, 6408.03879418091, 6422.486201103994, 6426.0, 6440.871182576416, 6244.906326405016, 6245.656488893154, 6298.874022519615, 6312.021636646327, 6321.620702757849, 6015.849603759941, 6198.318184999736, 6241.6879156041105, 6250.343713910156, 6251.562390632612, 6112.724927378367, 6120.081987701702, 6134.693265336805, 6139.754409823557, 6145.170401995852, 6268.52986026059, 6269.247690277196, 6270.843228919131, 6275.874482510416, 6277.435030847246, 5861.974154523026, 6123.969380153071, 6126.571140020156, 6132.264128304453, 6133.355997620186], "unit": "score", "name": "prototype.html", "value": 4653.626961821495}, {"lowerIsBetter": false, "replicates": [741.9591922444266, 786.4554888039321, 821.2157389692844, 839.6053854688298, 861.207688926188, 13748.175109493424, 14017.088889222194, 14072.64818379541, 14088.154710717365, 14088.295585220749, 12265.293006989517, 12440.626781196555, 12464.31446270457, 12517.0, 12522.874771252285, 825.9834803303916, 840.3361344537839, 841.9915800842005, 843.4981186194204, 844.3498506150261, 830.8089139497919, 832.6544484039116, 837.9581020948929, 838.2497664590219, 838.4214891724721, 874.9387542872001, 875.1030194051085, 877.5305211711735, 878.4377998081233, 879.2921698033081, 871.037503558565, 871.6644092024553, 871.6861929705365, 871.9520426376547, 874.1040433555625, 644.1465058797113, 644.954853160279, 645.1548471502347, 646.5894157210205, 646.7186773753385, 12796.0, 12863.485460581565, 12873.549425770147, 12882.742345153138, 12906.35468226585, 11471.942640286745, 11863.406829658483, 12035.0, 12108.0, 12211.511539538407, 10805.0, 11499.540018399253, 11612.941935290353, 11698.415079246004, 12000.759984800256, 3586.569611646593, 3613.403788374915, 3651.3610118229203, 3722.4788529605876, 3724.515812944327, 46687.533124668655, 46944.7652761734, 46956.0, 47021.529784702056, 51616.48383516154, 8284.792880177924, 10156.746081348025, 10249.743756406, 10367.118794902366, 10685.946570267255, 17102.48692539226, 17185.226664800113, 17250.482485525456, 17266.22301996413, 17268.568285792957, 6718.395344418928, 6805.183377994672, 6822.147231596051, 6836.623985680736, 7342.963285183647, 4109.650679692199, 4161.687873409506, 4162.125953549788, 4259.446271984622, 4445.866624001285, 3151.7636177286795, 3177.4757165067967, 3182.9681703183137, 3192.74458043356, 3199.936001279961, 605.1709158452948, 610.697704636208, 618.0790621973317, 619.5446346934999, 624.0483263023925, 632.3202557250974, 659.3735950846715, 659.8977158540434, 661.4528232863009, 679.6092246958019, 8355.0, 8688.782780430414, 8774.254188394058, 8784.824303513893, 8827.272184995918, 479.52287473962934, 597.3369559788631, 623.7006237006262, 644.5359341274275, 665.4044630056072, 4060.6954478414236, 4151.8962025949595, 4178.477690288714, 4233.153369326147, 4261.595148460891, 51937.220941685904, 53987.0, 54099.0, 54278.72860635751, 54587.727061364436, 47383.5261647386, 48518.78703032452, 48612.027759444616, 48665.27002094971, 48804.51195488, 39991.60008399937, 42558.78720606439, 44500.0, 49136.0, 49868.750656246484, 8952.507612081397, 9068.818623627358, 9081.0, 9129.497877616795, 9300.11648893354, 33925.83037084799, 34652.0, 34951.0, 35403.0, 35507.46738798972, 42576.0, 43795.12409751723, 44021.55978440175, 44155.337669935616, 44586.0, 10769.299995500267, 10890.549626334012, 11313.943430282796, 11332.490037948148, 11429.19940656072, 12505.687357816127, 12541.686457838627, 12762.553310634083, 12804.743905122032, 12911.5480958166, 11124.721881953015, 11306.152038597302, 11387.772244555228, 11747.823782643096, 12178.57374991871, 11197.88802112001, 11201.495932683212, 11883.702907427038, 12149.939250303692, 12154.270743755404, 11448.542058317575, 11710.473028713557, 11716.765664686489, 11976.221545599508, 12037.879621203676, 9240.168384845127, 9418.293627977791, 9464.621415143318, 9542.666006689733, 9733.124018838338, 9584.731230895623, 9755.756106097404, 9984.60061597528, 10160.136388407069, 10262.179025677779], "unit": "score", "name": "yui.html", "value": 6340.143153764231}], "name": "dromaeo_css", "value": 6808.230096348955}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 105.0, 109.0, 111.0, 113.0, 99.0, 111.0, 109.0, 110.0], "unit": "score", "name": "ai-astar", "value": 108.6}, {"lowerIsBetter": true, "replicates": [148.0, 127.0, 155.0, 171.0, 127.0, 154.0, 150.0, 127.0, 172.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 145.7}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 160.0, 163.0, 161.0, 161.0, 162.0, 161.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [76.0, 75.0, 93.0, 96.0, 76.0, 76.0, 73.0, 121.0, 117.0, 76.0], "unit": "score", "name": "audio-fft", "value": 87.9}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 142.0, 93.0, 93.0, 94.0, 134.0, 92.0, 93.0, 144.0], "unit": "score", "name": "audio-oscillator", "value": 107.2}, {"lowerIsBetter": true, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 118.0, 116.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.9}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.8}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [58.0, 57.0, 59.0, 57.0, 60.0, 57.0, 58.0, 67.0, 57.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 58.7}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 68.0, 68.0, 68.0, 68.0, 67.0, 67.0, 67.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.7}, {"lowerIsBetter": true, "replicates": [80.0, 88.0, 83.0, 83.0, 82.0, 81.0, 82.0, 81.0, 88.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.1}, {"lowerIsBetter": true, "replicates": [124.0, 119.0, 115.0, 116.0, 117.0, 119.0, 124.0, 115.0, 114.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.0}, {"lowerIsBetter": true, "replicates": [150.0, 148.0, 147.0, 148.0, 150.0, 147.0, 151.0, 149.0, 154.0, 161.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.5}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 70.0, 70.0, 72.0, 66.0, 72.0, 68.0, 72.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.1}], "name": "kraken", "value": 1516.1999999999998}]} 02:44:37 INFO - Return code: 0 02:44:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 02:44:37 INFO - # TBPL SUCCESS # 02:44:37 INFO - Running post-action listener: _resource_record_post_action 02:44:37 INFO - Running post-run listener: _resource_record_post_run 02:44:38 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 545894400; Read time: 20; Write time: 830176 02:44:38 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 0; Write bytes: 252321792; Read time: 0; Write time: 521480 02:44:38 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293507072; Read time: 20; Write time: 308656 02:44:38 INFO - Running post-run listener: _upload_blobber_files 02:44:38 INFO - Blob upload gear active. 02:44:38 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 02:44:38 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 02:44:38 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', 'Mozilla-Aurora', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 02:44:38 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 Mozilla-Aurora -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 02:44:38 INFO - (blobuploader) - INFO - Open directory for files ... 02:44:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:44:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:44:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:44:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:44:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:44:39 INFO - (blobuploader) - INFO - Done attempting. 02:44:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 02:44:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:44:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:44:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:44:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:44:40 INFO - (blobuploader) - INFO - Done attempting. 02:44:40 INFO - (blobuploader) - INFO - Iteration through files over. 02:44:40 INFO - Return code: 0 02:44:40 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 02:44:40 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 02:44:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b34a0d65db2052a6a0bb71561e3b45e56895e69c80dd26754ccc150369a2eb6cd76e95a5dacde0ff7690d25a37fd780e5fb58a5340f5cde9a30ec0abef6be48f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/73c0850b82e3cebecca9b440e450aa08e142cd190e82e63e405510c487691f5bb309b1160591b01c1f732fb25ca74b8f3256c0cb81c8bf73a7dc277be8455ba6"} 02:44:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 02:44:40 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 02:44:40 INFO - Contents: 02:44:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b34a0d65db2052a6a0bb71561e3b45e56895e69c80dd26754ccc150369a2eb6cd76e95a5dacde0ff7690d25a37fd780e5fb58a5340f5cde9a30ec0abef6be48f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/73c0850b82e3cebecca9b440e450aa08e142cd190e82e63e405510c487691f5bb309b1160591b01c1f732fb25ca74b8f3256c0cb81c8bf73a7dc277be8455ba6"} 02:44:40 INFO - Running post-run listener: copy_logs_to_upload_dir 02:44:40 INFO - Copying logs to upload dir... 02:44:40 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 02:44:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.774020 ========= master_lag: 1.92 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-03-08 02:44:42.187942) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-08 02:44:42.191101) ========= 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=aa52b8aba932b19cc50b5275000001de-1457432638.584047-1465674945 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b34a0d65db2052a6a0bb71561e3b45e56895e69c80dd26754ccc150369a2eb6cd76e95a5dacde0ff7690d25a37fd780e5fb58a5340f5cde9a30ec0abef6be48f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/73c0850b82e3cebecca9b440e450aa08e142cd190e82e63e405510c487691f5bb309b1160591b01c1f732fb25ca74b8f3256c0cb81c8bf73a7dc277be8455ba6"} build_url:https://queue.taskcluster.net/v1/task/DXC_oMDVQqezRTaaZpA3IQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011375 build_url: 'https://queue.taskcluster.net/v1/task/DXC_oMDVQqezRTaaZpA3IQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b34a0d65db2052a6a0bb71561e3b45e56895e69c80dd26754ccc150369a2eb6cd76e95a5dacde0ff7690d25a37fd780e5fb58a5340f5cde9a30ec0abef6be48f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/73c0850b82e3cebecca9b440e450aa08e142cd190e82e63e405510c487691f5bb309b1160591b01c1f732fb25ca74b8f3256c0cb81c8bf73a7dc277be8455ba6"}' ========= master_lag: 0.39 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-08 02:44:42.590925) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 02:44:42.591301) ========= 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=aa52b8aba932b19cc50b5275000001de-1457432638.584047-1465674945 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004528 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 02:44:42.617147) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-08 02:44:42.617488) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-08 02:44:42.621864) ========= ========= Total master_lag: 2.60 =========