builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-010 starttime: 1457357764.35 results: success (0) buildid: 20160307030208 builduid: 2ebdd262f61444c2a007a632327c1612 revision: 68d3781deda0d4d58ec9877862830db89669b3a5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-07 05:36:04.351786) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-07 05:36:04.352209) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-07 05:36:04.352498) ========= 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=eca2ab57546de7b41f256b19000001ef-1457357447.524786-547682945 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006369 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-07 05:36:04.384233) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-07 05:36:04.384538) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-07 05:36:04.424265) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 05:36:04.424513) ========= 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=eca2ab57546de7b41f256b19000001ef-1457357447.524786-547682945 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004572 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 05:36:04.473595) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-07 05:36:04.473866) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-07 05:36:04.474235) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 05:36:04.474503) ========= 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=eca2ab57546de7b41f256b19000001ef-1457357447.524786-547682945 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-07 05:36:05-- 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% 224M=0s 2016-03-07 05:36:05 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.111384 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 05:36:04.597640) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 05:36:04.597939) ========= 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=eca2ab57546de7b41f256b19000001ef-1457357447.524786-547682945 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022693 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 05:36:04.646956) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 05:36:04.647314) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 68d3781deda0d4d58ec9877862830db89669b3a5 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 68d3781deda0d4d58ec9877862830db89669b3a5 --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=eca2ab57546de7b41f256b19000001ef-1457357447.524786-547682945 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-07 05:36:05,672 truncating revision to first 12 chars 2016-03-07 05:36:05,672 Setting DEBUG logging. 2016-03-07 05:36:05,673 attempt 1/10 2016-03-07 05:36:05,673 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/68d3781deda0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-07 05:36:05,936 unpacking tar archive at: mozilla-central-68d3781deda0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.521735 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 05:36:05.182187) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-07 05:36:05.182507) ========= echo 68d3781deda0d4d58ec9877862830db89669b3a5 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'68d3781deda0d4d58ec9877862830db89669b3a5'] 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=eca2ab57546de7b41f256b19000001ef-1457357447.524786-547682945 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 68d3781deda0d4d58ec9877862830db89669b3a5 program finished with exit code 0 elapsedTime=0.004671 script_repo_revision: '68d3781deda0d4d58ec9877862830db89669b3a5' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-07 05:36:05.231856) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-07 05:36:05.232175) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-07 05:36:05.241593) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-03-07 05:36:05.241965) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1457357447.524786-547682945 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:36:06 INFO - MultiFileLogger online at 20160307 05:36:06 in /builds/slave/test-pgo 05:36:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:36:06 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:36:06 INFO - {'append_to_log': False, 05:36:06 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:36:06 INFO - 'blob_upload_branch': 'Firefox', 05:36:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:36:06 INFO - 'branch': 'Firefox', 05:36:06 INFO - 'buildbot_json_path': 'buildprops.json', 05:36:06 INFO - 'config_files': ('talos/linux_config.py',), 05:36:06 INFO - 'default_actions': ('clobber', 05:36:06 INFO - 'read-buildbot-config', 05:36:06 INFO - 'download-and-extract', 05:36:06 INFO - 'populate-webroot', 05:36:06 INFO - 'create-virtualenv', 05:36:06 INFO - 'install', 05:36:06 INFO - 'run-tests'), 05:36:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:36:06 INFO - 'download_minidump_stackwalk': True, 05:36:06 INFO - 'download_symbols': 'ondemand', 05:36:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:36:06 INFO - 'tooltool.py': '/tools/tooltool.py', 05:36:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:36:06 INFO - '/tools/misc-python/virtualenv.py')}, 05:36:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:36:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:36:06 INFO - 'installer_path': 'installer.exe', 05:36:06 INFO - 'log_level': 'info', 05:36:06 INFO - 'log_name': 'talos', 05:36:06 INFO - 'log_to_console': True, 05:36:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:36:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:36:06 INFO - 'opt_config_files': (), 05:36:06 INFO - 'pip_index': False, 05:36:06 INFO - 'sps_profile': False, 05:36:06 INFO - 'sps_profile_interval': 0, 05:36:06 INFO - 'suite': 'dromaeojs', 05:36:06 INFO - 'system_bits': '32', 05:36:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:36:06 INFO - 'title': 'talos-linux64-ix-010', 05:36:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:36:06 INFO - 'use_talos_json': True, 05:36:06 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:36:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:36:06 INFO - 'work_dir': 'build'} 05:36:06 INFO - ##### 05:36:06 INFO - ##### Running clobber step. 05:36:06 INFO - ##### 05:36:06 INFO - Running pre-action listener: _resource_record_pre_action 05:36:06 INFO - Running main action method: clobber 05:36:06 INFO - rmtree: /builds/slave/test-pgo/build 05:36:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:36:06 INFO - Running post-action listener: _resource_record_post_action 05:36:06 INFO - ##### 05:36:06 INFO - ##### Running read-buildbot-config step. 05:36:06 INFO - ##### 05:36:06 INFO - Running pre-action listener: _resource_record_pre_action 05:36:06 INFO - Running main action method: read_buildbot_config 05:36:06 INFO - Using buildbot properties: 05:36:06 INFO - { 05:36:06 INFO - "project": "", 05:36:06 INFO - "product": "firefox", 05:36:06 INFO - "script_repo_revision": "production", 05:36:06 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:36:06 INFO - "repository": "", 05:36:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:36:06 INFO - "buildid": "20160307030208", 05:36:06 INFO - "stage_platform": "linux64-pgo", 05:36:06 INFO - "basedir": "/builds/slave/test-pgo", 05:36:06 INFO - "nightly_build": "True", 05:36:06 INFO - "buildnumber": 211, 05:36:06 INFO - "slavename": "talos-linux64-ix-010", 05:36:06 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:36:06 INFO - "platform": "ubuntu64_hw", 05:36:06 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:36:06 INFO - "branch": "mozilla-central", 05:36:06 INFO - "repo_path": "mozilla-central", 05:36:06 INFO - "revision": "68d3781deda0d4d58ec9877862830db89669b3a5", 05:36:06 INFO - "pgo_build": "True", 05:36:06 INFO - "builduid": "2ebdd262f61444c2a007a632327c1612", 05:36:06 INFO - "slavebuilddir": "test" 05:36:06 INFO - } 05:36:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/GCOOGTTQTRePB11bu1avvg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 05:36:06 INFO - Running post-action listener: _resource_record_post_action 05:36:06 INFO - ##### 05:36:06 INFO - ##### Running download-and-extract step. 05:36:06 INFO - ##### 05:36:06 INFO - Running pre-action listener: _resource_record_pre_action 05:36:06 INFO - Running main action method: download_and_extract 05:36:06 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:36:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:06 INFO - https://queue.taskcluster.net/v1/task/GCOOGTTQTRePB11bu1avvg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:36:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCOOGTTQTRePB11bu1avvg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 05:36:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCOOGTTQTRePB11bu1avvg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 05:36:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCOOGTTQTRePB11bu1avvg/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 05:36:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCOOGTTQTRePB11bu1avvg/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 05:36:13 INFO - Downloaded 1448 bytes. 05:36:13 INFO - Reading from file /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 05:36:13 INFO - Using the following test package requirements: 05:36:13 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 05:36:13 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:36:13 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:36:13 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:36:13 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:36:13 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:36:13 INFO - u'jsshell-linux-x86_64.zip'], 05:36:13 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:36:13 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:36:13 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 05:36:13 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:36:13 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:36:13 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:36:13 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:36:13 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:36:13 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:36:13 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 05:36:13 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:36:13 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:36:13 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:36:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:13 INFO - https://queue.taskcluster.net/v1/task/GCOOGTTQTRePB11bu1avvg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:36:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCOOGTTQTRePB11bu1avvg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:36:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCOOGTTQTRePB11bu1avvg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:36:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCOOGTTQTRePB11bu1avvg/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 05:36:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCOOGTTQTRePB11bu1avvg/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 05:36:17 INFO - Downloaded 23405721 bytes. 05:36:17 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'] 05:36:17 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 05:36:18 INFO - Return code: 0 05:36:18 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 05:36: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')]} 05:36:18 INFO - https://queue.taskcluster.net/v1/task/GCOOGTTQTRePB11bu1avvg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:36:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCOOGTTQTRePB11bu1avvg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:36:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCOOGTTQTRePB11bu1avvg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:36:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCOOGTTQTRePB11bu1avvg/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 05:36:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCOOGTTQTRePB11bu1avvg/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 05:36:20 INFO - Downloaded 23405721 bytes. 05:36:20 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'] 05:36:20 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 05:36:21 INFO - Return code: 0 05:36:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:21 INFO - https://queue.taskcluster.net/v1/task/GCOOGTTQTRePB11bu1avvg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:36:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCOOGTTQTRePB11bu1avvg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 05:36:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCOOGTTQTRePB11bu1avvg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 05:36:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCOOGTTQTRePB11bu1avvg/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 05:36:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCOOGTTQTRePB11bu1avvg/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 05:36:22 INFO - Downloaded 10845161 bytes. 05:36:22 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'] 05:36:22 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 05:36:22 INFO - Return code: 0 05:36:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:22 INFO - https://queue.taskcluster.net/v1/task/GCOOGTTQTRePB11bu1avvg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:36:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCOOGTTQTRePB11bu1avvg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:36:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCOOGTTQTRePB11bu1avvg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:36:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCOOGTTQTRePB11bu1avvg/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 05:36:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCOOGTTQTRePB11bu1avvg/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 05:36:24 INFO - Downloaded 56183726 bytes. 05:36:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GCOOGTTQTRePB11bu1avvg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:36:24 INFO - mkdir: /builds/slave/test-pgo/properties 05:36:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:36:24 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:36:24 INFO - Contents: 05:36:24 INFO - build_url:https://queue.taskcluster.net/v1/task/GCOOGTTQTRePB11bu1avvg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:36:24 INFO - Running post-action listener: _resource_record_post_action 05:36:24 INFO - Running post-action listener: set_extra_try_arguments 05:36:24 INFO - ##### 05:36:24 INFO - ##### Running populate-webroot step. 05:36:24 INFO - ##### 05:36:24 INFO - Running pre-action listener: _resource_record_pre_action 05:36:24 INFO - Running main action method: populate_webroot 05:36:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:36:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:36:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:36:24 INFO - '--tppagecycles', 05:36:24 INFO - '7'], 05:36:24 INFO - 'tests': ['tsvgm']}}, 05:36:24 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:36:24 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:36:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:36:24 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:36:24 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:36:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:36:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:36:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:36:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:36:24 INFO - 'talos_options': ['--e10s'], 05:36:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:36:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:36:24 INFO - 'tests': ['damp', 'tps']}, 05:36:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:36:24 INFO - 'talos_options': ['--e10s'], 05:36:24 INFO - 'tests': ['damp', 'tps']}, 05:36:24 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:36:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:36:24 INFO - 'other': {'tests': ['a11yr', 05:36:24 INFO - 'ts_paint', 05:36:24 INFO - 'tpaint', 05:36:24 INFO - 'sessionrestore', 05:36:24 INFO - 'sessionrestore_no_auto_restore', 05:36:24 INFO - 'tabpaint']}, 05:36:24 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:36:24 INFO - 'tests': ['a11yr', 05:36:24 INFO - 'ts_paint', 05:36:24 INFO - 'tpaint', 05:36:24 INFO - 'sessionrestore', 05:36:24 INFO - 'sessionrestore_no_auto_restore', 05:36:24 INFO - 'tabpaint']}, 05:36:24 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:36:24 INFO - 'tests': ['a11yr', 05:36:24 INFO - 'ts_paint', 05:36:24 INFO - 'tpaint', 05:36:24 INFO - 'sessionrestore', 05:36:24 INFO - 'sessionrestore_no_auto_restore', 05:36:24 INFO - 'tabpaint']}, 05:36:24 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:36:24 INFO - 'tests': ['a11yr', 05:36:24 INFO - 'ts_paint', 05:36:24 INFO - 'tpaint', 05:36:24 INFO - 'sessionrestore', 05:36:24 INFO - 'sessionrestore_no_auto_restore', 05:36:24 INFO - 'tabpaint']}, 05:36:24 INFO - 'other_l64': {'tests': ['a11yr', 05:36:24 INFO - 'ts_paint', 05:36:24 INFO - 'tpaint', 05:36:24 INFO - 'sessionrestore', 05:36:24 INFO - 'sessionrestore_no_auto_restore', 05:36:24 INFO - 'tabpaint']}, 05:36:24 INFO - 'other_nol64': {'tests': ['a11yr', 05:36:24 INFO - 'ts_paint', 05:36:24 INFO - 'tpaint', 05:36:24 INFO - 'sessionrestore', 05:36:24 INFO - 'sessionrestore_no_auto_restore', 05:36:24 INFO - 'tabpaint']}, 05:36:24 INFO - 'svgr': {'tests': ['tsvgx', 05:36:24 INFO - 'tsvgr_opacity', 05:36:24 INFO - 'tart', 05:36:24 INFO - 'tscrollx', 05:36:24 INFO - 'cart']}, 05:36:24 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:36:24 INFO - 'tests': ['tsvgx', 05:36:24 INFO - 'tsvgr_opacity', 05:36:24 INFO - 'tart', 05:36:24 INFO - 'tscrollx', 05:36:24 INFO - 'cart']}, 05:36:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:36:24 INFO - 'tests': ['tp5o']}, 05:36:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:36:24 INFO - 'talos_options': ['--e10s'], 05:36:24 INFO - 'tests': ['tp5o']}, 05:36:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:36:24 INFO - 'talos_options': ['--xperf_path', 05:36:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:36:24 INFO - 'tests': ['tp5n']}, 05:36:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:36:24 INFO - 'talos_options': ['--e10s', 05:36:24 INFO - '--xperf_path', 05:36:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:36:24 INFO - 'tests': ['tp5n']}}, 05:36:24 INFO - 'talos.zip': {'path': '', 05:36:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:36:24 INFO - Running post-action listener: _resource_record_post_action 05:36:24 INFO - ##### 05:36:24 INFO - ##### Running create-virtualenv step. 05:36:24 INFO - ##### 05:36:24 INFO - Running pre-action listener: _resource_record_pre_action 05:36:24 INFO - Running main action method: create_virtualenv 05:36:24 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:36:24 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 05:36:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:36:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:36:24 INFO - Using real prefix '/usr' 05:36:24 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:36:25 INFO - Installing distribute.............................................................................................................................................................................................done. 05:36:27 INFO - Installing pip.................done. 05:36:27 INFO - Return code: 0 05:36:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:36:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:27 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 0x7ffd24e1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12bb6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134a920>, '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 0x134b820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134bcb0>, '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': 'eca2ab57546de7b41f256b19000001ef-1457357447.524786-547682945', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:36:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 05:36:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:36:27 INFO - Using env: {'DISPLAY': ':0', 05:36:27 INFO - 'HOME': '/home/cltbld', 05:36:27 INFO - 'LANG': 'en_US.UTF-8', 05:36:27 INFO - 'LANGUAGE': 'en_US:en', 05:36:27 INFO - 'LOGNAME': 'cltbld', 05:36:27 INFO - 'MAIL': '/var/mail/cltbld', 05:36:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:27 INFO - 'MOZ_NO_REMOTE': '1', 05:36:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:27 INFO - 'NO_EM_RESTART': '1', 05:36:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:36:27 INFO - 'PWD': '/builds/slave/test-pgo', 05:36:27 INFO - 'SHELL': '/bin/bash', 05:36:27 INFO - 'SHLVL': '1', 05:36:27 INFO - 'TERM': 'linux', 05:36:27 INFO - 'TMOUT': '86400', 05:36:27 INFO - 'USER': 'cltbld', 05:36:27 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1457357447.524786-547682945', 05:36:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:27 INFO - '_': '/tools/buildbot/bin/python'} 05:36:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:27 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:36:27 INFO - Cleaning up... 05:36:27 INFO - Return code: 0 05:36:27 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:36:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:27 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 0x7ffd24e1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12bb6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134a920>, '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 0x134b820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134bcb0>, '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': 'eca2ab57546de7b41f256b19000001ef-1457357447.524786-547682945', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:36:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:36:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:36:27 INFO - Using env: {'DISPLAY': ':0', 05:36:27 INFO - 'HOME': '/home/cltbld', 05:36:27 INFO - 'LANG': 'en_US.UTF-8', 05:36:27 INFO - 'LANGUAGE': 'en_US:en', 05:36:27 INFO - 'LOGNAME': 'cltbld', 05:36:27 INFO - 'MAIL': '/var/mail/cltbld', 05:36:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:27 INFO - 'MOZ_NO_REMOTE': '1', 05:36:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:27 INFO - 'NO_EM_RESTART': '1', 05:36:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:36:27 INFO - 'PWD': '/builds/slave/test-pgo', 05:36:27 INFO - 'SHELL': '/bin/bash', 05:36:27 INFO - 'SHLVL': '1', 05:36:27 INFO - 'TERM': 'linux', 05:36:27 INFO - 'TMOUT': '86400', 05:36:27 INFO - 'USER': 'cltbld', 05:36:27 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1457357447.524786-547682945', 05:36:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:27 INFO - '_': '/tools/buildbot/bin/python'} 05:36:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:27 INFO - Downloading/unpacking psutil>=0.7.1 05:36:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:36:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:36:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:36:29 INFO - Installing collected packages: psutil 05:36:29 INFO - Running setup.py install for psutil 05:36:29 INFO - building 'psutil._psutil_linux' extension 05:36:29 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:36:30 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:36:30 INFO - building 'psutil._psutil_posix' extension 05:36:30 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:36:30 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:36:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:36:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:36:30 INFO - Successfully installed psutil 05:36:30 INFO - Cleaning up... 05:36:30 INFO - Return code: 0 05:36:30 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:36:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:30 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 0x7ffd24e1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12bb6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134a920>, '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 0x134b820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134bcb0>, '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': 'eca2ab57546de7b41f256b19000001ef-1457357447.524786-547682945', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:36:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 05:36:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:36:30 INFO - Using env: {'DISPLAY': ':0', 05:36:30 INFO - 'HOME': '/home/cltbld', 05:36:30 INFO - 'LANG': 'en_US.UTF-8', 05:36:30 INFO - 'LANGUAGE': 'en_US:en', 05:36:30 INFO - 'LOGNAME': 'cltbld', 05:36:30 INFO - 'MAIL': '/var/mail/cltbld', 05:36:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:30 INFO - 'MOZ_NO_REMOTE': '1', 05:36:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:30 INFO - 'NO_EM_RESTART': '1', 05:36:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:36:30 INFO - 'PWD': '/builds/slave/test-pgo', 05:36:30 INFO - 'SHELL': '/bin/bash', 05:36:30 INFO - 'SHLVL': '1', 05:36:30 INFO - 'TERM': 'linux', 05:36:30 INFO - 'TMOUT': '86400', 05:36:30 INFO - 'USER': 'cltbld', 05:36:30 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1457357447.524786-547682945', 05:36:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:30 INFO - '_': '/tools/buildbot/bin/python'} 05:36:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:30 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:36:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:32 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:36:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:36:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:36:32 INFO - Installing collected packages: mozsystemmonitor 05:36:32 INFO - Running setup.py install for mozsystemmonitor 05:36:32 INFO - Successfully installed mozsystemmonitor 05:36:32 INFO - Cleaning up... 05:36:32 INFO - Return code: 0 05:36:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:36: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')]} 05:36:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36: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')]} 05:36:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:32 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ffd24e1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12bb6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134a920>, '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 0x134b820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134bcb0>, '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': 'eca2ab57546de7b41f256b19000001ef-1457357447.524786-547682945', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:36:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 05:36:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:36:32 INFO - Using env: {'DISPLAY': ':0', 05:36:32 INFO - 'HOME': '/home/cltbld', 05:36:32 INFO - 'LANG': 'en_US.UTF-8', 05:36:32 INFO - 'LANGUAGE': 'en_US:en', 05:36:32 INFO - 'LOGNAME': 'cltbld', 05:36:32 INFO - 'MAIL': '/var/mail/cltbld', 05:36:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:32 INFO - 'MOZ_NO_REMOTE': '1', 05:36:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:32 INFO - 'NO_EM_RESTART': '1', 05:36:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:36:32 INFO - 'PWD': '/builds/slave/test-pgo', 05:36:32 INFO - 'SHELL': '/bin/bash', 05:36:32 INFO - 'SHLVL': '1', 05:36:32 INFO - 'TERM': 'linux', 05:36:32 INFO - 'TMOUT': '86400', 05:36:32 INFO - 'USER': 'cltbld', 05:36:32 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1457357447.524786-547682945', 05:36:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:32 INFO - '_': '/tools/buildbot/bin/python'} 05:36:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:32 INFO - Downloading/unpacking blobuploader==1.2.4 05:36:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:34 INFO - Downloading blobuploader-1.2.4.tar.gz 05:36:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:36:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:36:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:36:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:35 INFO - Downloading docopt-0.6.1.tar.gz 05:36:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:36:35 INFO - Installing collected packages: blobuploader, requests, docopt 05:36:35 INFO - Running setup.py install for blobuploader 05:36:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:36:35 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:36:35 INFO - Running setup.py install for requests 05:36:35 INFO - Running setup.py install for docopt 05:36:35 INFO - Successfully installed blobuploader requests docopt 05:36:35 INFO - Cleaning up... 05:36:35 INFO - Return code: 0 05:36:35 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:36:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:35 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 0x7ffd24e1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12bb6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134a920>, '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 0x134b820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134bcb0>, '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': 'eca2ab57546de7b41f256b19000001ef-1457357447.524786-547682945', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:36:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:36:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:36:35 INFO - Using env: {'DISPLAY': ':0', 05:36:35 INFO - 'HOME': '/home/cltbld', 05:36:35 INFO - 'LANG': 'en_US.UTF-8', 05:36:35 INFO - 'LANGUAGE': 'en_US:en', 05:36:35 INFO - 'LOGNAME': 'cltbld', 05:36:35 INFO - 'MAIL': '/var/mail/cltbld', 05:36:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:35 INFO - 'MOZ_NO_REMOTE': '1', 05:36:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:35 INFO - 'NO_EM_RESTART': '1', 05:36:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:36:35 INFO - 'PWD': '/builds/slave/test-pgo', 05:36:35 INFO - 'SHELL': '/bin/bash', 05:36:35 INFO - 'SHLVL': '1', 05:36:35 INFO - 'TERM': 'linux', 05:36:35 INFO - 'TMOUT': '86400', 05:36:35 INFO - 'USER': 'cltbld', 05:36:35 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1457357447.524786-547682945', 05:36:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:35 INFO - '_': '/tools/buildbot/bin/python'} 05:36:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:36:36 INFO - Running setup.py (path:/tmp/pip-_cCp2s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:36:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:36:36 INFO - Running setup.py (path:/tmp/pip-zGdBZF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:36:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:36:36 INFO - Running setup.py (path:/tmp/pip-V_KkSd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:36:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:36:36 INFO - Running setup.py (path:/tmp/pip-BQjDVB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:36:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:36:36 INFO - Running setup.py (path:/tmp/pip-KGBkhw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:36:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:36:36 INFO - Running setup.py (path:/tmp/pip-mPAPMe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:36:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:36:36 INFO - Running setup.py (path:/tmp/pip-95dwaw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:36:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:36:36 INFO - Running setup.py (path:/tmp/pip-rSKRl2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:36:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:36:36 INFO - Running setup.py (path:/tmp/pip-r7LNwP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:36:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:36:36 INFO - Running setup.py (path:/tmp/pip-DlwAd_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:36:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:36:36 INFO - Running setup.py (path:/tmp/pip-1D1lMD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:36:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:36:36 INFO - Running setup.py (path:/tmp/pip-37fdM6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:36:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:36:37 INFO - Running setup.py (path:/tmp/pip-tCiM6C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:36:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:36:37 INFO - Running setup.py (path:/tmp/pip-F9MtqI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:36:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:36:37 INFO - Running setup.py (path:/tmp/pip-tUam_p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:36:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:36:37 INFO - Running setup.py (path:/tmp/pip-1Zlppk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:36:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:36:37 INFO - Running setup.py (path:/tmp/pip-eD4Yha-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:36:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:36:37 INFO - Running setup.py install for manifestparser 05:36:37 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:36:37 INFO - Running setup.py install for mozcrash 05:36:37 INFO - Running setup.py install for mozdebug 05:36:37 INFO - Running setup.py install for mozdevice 05:36:37 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:36:37 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:36:37 INFO - Running setup.py install for mozfile 05:36:37 INFO - Running setup.py install for mozhttpd 05:36:37 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:36:37 INFO - Running setup.py install for mozinfo 05:36:38 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:36:38 INFO - Running setup.py install for mozInstall 05:36:38 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:36:38 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:36:38 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:36:38 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:36:38 INFO - Running setup.py install for mozleak 05:36:38 INFO - Running setup.py install for mozlog 05:36:38 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:36:38 INFO - Running setup.py install for moznetwork 05:36:38 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:36:38 INFO - Running setup.py install for mozprocess 05:36:38 INFO - Running setup.py install for mozprofile 05:36:38 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:36:38 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:36:38 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:36:38 INFO - Running setup.py install for mozrunner 05:36:38 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:36:38 INFO - Running setup.py install for mozscreenshot 05:36:38 INFO - Running setup.py install for moztest 05:36:39 INFO - Running setup.py install for mozversion 05:36:39 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:36:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:36:39 INFO - Cleaning up... 05:36:39 INFO - Return code: 0 05:36:39 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:36: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')]} 05:36:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36: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')]} 05:36:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36: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/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 0x7ffd24e1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12bb6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134a920>, '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 0x134b820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134bcb0>, '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': 'eca2ab57546de7b41f256b19000001ef-1457357447.524786-547682945', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:36:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:36:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:36:39 INFO - Using env: {'DISPLAY': ':0', 05:36:39 INFO - 'HOME': '/home/cltbld', 05:36:39 INFO - 'LANG': 'en_US.UTF-8', 05:36:39 INFO - 'LANGUAGE': 'en_US:en', 05:36:39 INFO - 'LOGNAME': 'cltbld', 05:36:39 INFO - 'MAIL': '/var/mail/cltbld', 05:36:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:39 INFO - 'MOZ_NO_REMOTE': '1', 05:36:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:39 INFO - 'NO_EM_RESTART': '1', 05:36:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:36:39 INFO - 'PWD': '/builds/slave/test-pgo', 05:36:39 INFO - 'SHELL': '/bin/bash', 05:36:39 INFO - 'SHLVL': '1', 05:36:39 INFO - 'TERM': 'linux', 05:36:39 INFO - 'TMOUT': '86400', 05:36:39 INFO - 'USER': 'cltbld', 05:36:39 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1457357447.524786-547682945', 05:36:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:39 INFO - '_': '/tools/buildbot/bin/python'} 05:36:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:36:39 INFO - Running setup.py (path:/tmp/pip-H_sEI2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:36:39 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 05:36:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:36:39 INFO - Running setup.py (path:/tmp/pip-Ve7e1b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:36:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:36:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:36:39 INFO - Running setup.py (path:/tmp/pip-lucSBc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:36:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:36:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:36:39 INFO - Running setup.py (path:/tmp/pip-nMrYzf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:36:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:36:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:36:39 INFO - Running setup.py (path:/tmp/pip-pF5FKl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:36:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 05:36:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:36:39 INFO - Running setup.py (path:/tmp/pip-DRGiRz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:36:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 05:36:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:36:39 INFO - Running setup.py (path:/tmp/pip-xZ98cu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:36:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 05:36:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:36:39 INFO - Running setup.py (path:/tmp/pip-OC_poW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:36:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 05:36:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:36:39 INFO - Running setup.py (path:/tmp/pip-l9JQOm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:36:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 05:36:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:36:40 INFO - Running setup.py (path:/tmp/pip-vKkxDH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:36:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:36:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:36:40 INFO - Running setup.py (path:/tmp/pip-8VfigN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:36:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 05:36:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:36:40 INFO - Running setup.py (path:/tmp/pip-gPXJy0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:36:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 05:36:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:36:40 INFO - Running setup.py (path:/tmp/pip-S016_N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:36:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 05:36:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:36:40 INFO - Running setup.py (path:/tmp/pip-WMwwtT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:36:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 05:36:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:36:40 INFO - Running setup.py (path:/tmp/pip-fS7i5Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:36:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 05:36:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:36:40 INFO - Running setup.py (path:/tmp/pip-sugZUL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:36:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 05:36:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:36:40 INFO - Running setup.py (path:/tmp/pip-5k_b6e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:36:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 05:36:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:36:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:36:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:36:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:36:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:36:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:36:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:42 INFO - Downloading blessings-1.6.tar.gz 05:36:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:36:42 INFO - Installing collected packages: blessings 05:36:42 INFO - Running setup.py install for blessings 05:36:42 INFO - Successfully installed blessings 05:36:42 INFO - Cleaning up... 05:36:42 INFO - Return code: 0 05:36:42 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:36:42 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:36:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:36:42 INFO - Reading from file tmpfile_stdout 05:36:42 INFO - Current package versions: 05:36:42 INFO - argparse == 1.2.1 05:36:42 INFO - blessings == 1.6 05:36:42 INFO - blobuploader == 1.2.4 05:36:42 INFO - docopt == 0.6.1 05:36:42 INFO - manifestparser == 1.1 05:36:42 INFO - mozInstall == 1.12 05:36:42 INFO - mozcrash == 0.17 05:36:42 INFO - mozdebug == 0.1 05:36:42 INFO - mozdevice == 0.48 05:36:42 INFO - mozfile == 1.2 05:36:42 INFO - mozhttpd == 0.7 05:36:42 INFO - mozinfo == 0.9 05:36:42 INFO - mozleak == 0.1 05:36:42 INFO - mozlog == 3.1 05:36:42 INFO - moznetwork == 0.27 05:36:42 INFO - mozprocess == 0.22 05:36:42 INFO - mozprofile == 0.28 05:36:42 INFO - mozrunner == 6.11 05:36:42 INFO - mozscreenshot == 0.1 05:36:42 INFO - mozsystemmonitor == 0.0 05:36:42 INFO - moztest == 0.7 05:36:42 INFO - mozversion == 1.4 05:36:42 INFO - psutil == 3.1.1 05:36:42 INFO - requests == 1.2.3 05:36:42 INFO - wsgiref == 0.1.2 05:36:42 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:36: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')]} 05:36:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36: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')]} 05:36:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:42 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 0x7ffd24e1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12bb6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134a920>, '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 0x134b820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134bcb0>, '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': 'eca2ab57546de7b41f256b19000001ef-1457357447.524786-547682945', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:36:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 05:36:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:36:42 INFO - Using env: {'DISPLAY': ':0', 05:36:42 INFO - 'HOME': '/home/cltbld', 05:36:42 INFO - 'LANG': 'en_US.UTF-8', 05:36:42 INFO - 'LANGUAGE': 'en_US:en', 05:36:42 INFO - 'LOGNAME': 'cltbld', 05:36:42 INFO - 'MAIL': '/var/mail/cltbld', 05:36:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:42 INFO - 'MOZ_NO_REMOTE': '1', 05:36:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:42 INFO - 'NO_EM_RESTART': '1', 05:36:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:36:42 INFO - 'PWD': '/builds/slave/test-pgo', 05:36:42 INFO - 'SHELL': '/bin/bash', 05:36:42 INFO - 'SHLVL': '1', 05:36:42 INFO - 'TERM': 'linux', 05:36:42 INFO - 'TMOUT': '86400', 05:36:42 INFO - 'USER': 'cltbld', 05:36:42 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1457357447.524786-547682945', 05:36:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:42 INFO - '_': '/tools/buildbot/bin/python'} 05:36:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:36:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 05:36:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 05:36:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:36:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 05:36:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 05:36:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 05:36:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 05:36:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 05:36:43 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:36:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:36:43 INFO - Cleaning up... 05:36:43 INFO - Return code: 0 05:36:43 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:36:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:43 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 0x7ffd24e1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12bb6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134a920>, '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 0x134b820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134bcb0>, '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': 'eca2ab57546de7b41f256b19000001ef-1457357447.524786-547682945', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:36:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 05:36:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:36:43 INFO - Using env: {'DISPLAY': ':0', 05:36:43 INFO - 'HOME': '/home/cltbld', 05:36:43 INFO - 'LANG': 'en_US.UTF-8', 05:36:43 INFO - 'LANGUAGE': 'en_US:en', 05:36:43 INFO - 'LOGNAME': 'cltbld', 05:36:43 INFO - 'MAIL': '/var/mail/cltbld', 05:36:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:43 INFO - 'MOZ_NO_REMOTE': '1', 05:36:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:43 INFO - 'NO_EM_RESTART': '1', 05:36:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:36:43 INFO - 'PWD': '/builds/slave/test-pgo', 05:36:43 INFO - 'SHELL': '/bin/bash', 05:36:43 INFO - 'SHLVL': '1', 05:36:43 INFO - 'TERM': 'linux', 05:36:43 INFO - 'TMOUT': '86400', 05:36:43 INFO - 'USER': 'cltbld', 05:36:43 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1457357447.524786-547682945', 05:36:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:43 INFO - '_': '/tools/buildbot/bin/python'} 05:36:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:43 INFO - Downloading/unpacking jsonschema 05:36:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:36:45 INFO - Downloading/unpacking functools32 (from jsonschema) 05:36:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:45 INFO - Downloading functools32-3.2.3-2.tar.gz 05:36:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:36:45 INFO - warning: no files found matching '*.txt' 05:36:45 INFO - no previously-included directories found matching 'build' 05:36:45 INFO - no previously-included directories found matching 'dist' 05:36:45 INFO - no previously-included directories found matching '.git*' 05:36:45 INFO - Installing collected packages: jsonschema, functools32 05:36:45 INFO - Running setup.py install for functools32 05:36:45 INFO - warning: no files found matching '*.txt' 05:36:45 INFO - no previously-included directories found matching 'build' 05:36:45 INFO - no previously-included directories found matching 'dist' 05:36:45 INFO - no previously-included directories found matching '.git*' 05:36:45 INFO - Successfully installed jsonschema functools32 05:36:45 INFO - Cleaning up... 05:36:45 INFO - Return code: 0 05:36:45 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:36:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:45 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 0x7ffd24e1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12bb6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134a920>, '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 0x134b820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134bcb0>, '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': 'eca2ab57546de7b41f256b19000001ef-1457357447.524786-547682945', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:36:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 05:36:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:36:45 INFO - Using env: {'DISPLAY': ':0', 05:36:45 INFO - 'HOME': '/home/cltbld', 05:36:45 INFO - 'LANG': 'en_US.UTF-8', 05:36:45 INFO - 'LANGUAGE': 'en_US:en', 05:36:45 INFO - 'LOGNAME': 'cltbld', 05:36:45 INFO - 'MAIL': '/var/mail/cltbld', 05:36:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:45 INFO - 'MOZ_NO_REMOTE': '1', 05:36:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:45 INFO - 'NO_EM_RESTART': '1', 05:36:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:36:45 INFO - 'PWD': '/builds/slave/test-pgo', 05:36:45 INFO - 'SHELL': '/bin/bash', 05:36:45 INFO - 'SHLVL': '1', 05:36:45 INFO - 'TERM': 'linux', 05:36:45 INFO - 'TMOUT': '86400', 05:36:45 INFO - 'USER': 'cltbld', 05:36:45 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1457357447.524786-547682945', 05:36:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:45 INFO - '_': '/tools/buildbot/bin/python'} 05:36:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:45 INFO - Downloading/unpacking flake8 05:36:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:47 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:36:47 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:36:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:36:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:36:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:48 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:36:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:36:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:36:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:36:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:36:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:36:48 INFO - no previously-included directories found matching 'docs/_build' 05:36:48 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:36:48 INFO - Running setup.py install for pep8 05:36:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:36:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:36:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:36:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:36:48 INFO - no previously-included directories found matching 'docs/_build' 05:36:48 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:36:48 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:36:48 INFO - Cleaning up... 05:36:48 INFO - Return code: 0 05:36:48 INFO - Running post-action listener: _resource_record_post_action 05:36:48 INFO - Running post-action listener: _start_resource_monitoring 05:36:48 INFO - Starting resource monitoring. 05:36:48 INFO - ##### 05:36:48 INFO - ##### Running install step. 05:36:48 INFO - ##### 05:36:48 INFO - Running pre-action listener: _resource_record_pre_action 05:36:48 INFO - Running main action method: install 05:36:48 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:36:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:36:48 INFO - Reading from file tmpfile_stdout 05:36:48 INFO - Detecting whether we're running mozinstall >=1.0... 05:36:48 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:36:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:36:48 INFO - Reading from file tmpfile_stdout 05:36:48 INFO - Output received: 05:36:48 INFO - Usage: mozinstall [options] installer 05:36:48 INFO - Options: 05:36:48 INFO - -h, --help show this help message and exit 05:36:48 INFO - -d DEST, --destination=DEST 05:36:48 INFO - Directory to install application into. [default: 05:36:48 INFO - "/builds/slave/test-pgo"] 05:36:48 INFO - --app=APP Application being installed. [default: firefox] 05:36:48 INFO - mkdir: /builds/slave/test-pgo/build/application 05:36:48 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'] 05:36:48 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 05:37:05 INFO - Reading from file tmpfile_stdout 05:37:05 INFO - Output received: 05:37:05 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:37:05 INFO - Running post-action listener: _resource_record_post_action 05:37:05 INFO - ##### 05:37:05 INFO - ##### Running run-tests step. 05:37:05 INFO - ##### 05:37:05 INFO - Running pre-action listener: _resource_record_pre_action 05:37:05 INFO - Running main action method: run_tests 05:37:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:37:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:37:05 INFO - Python 2.7.3 05:37:05 INFO - Return code: 0 05:37:05 INFO - grabbing minidump binary from tooltool 05:37:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:05 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 0x134a920>, '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 0x134b820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134bcb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:37:05 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 05:37:05 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:37:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:37:05 INFO - Return code: 0 05:37:05 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:37:05 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:37:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:37:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:37:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:37:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:37:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:37:06 INFO - Return code: 0 05:37:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GCOOGTTQTRePB11bu1avvg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 05:37:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GCOOGTTQTRePB11bu1avvg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 05:37:06 INFO - Using env: {'DISPLAY': ':0', 05:37:06 INFO - 'HOME': '/home/cltbld', 05:37:06 INFO - 'LANG': 'en_US.UTF-8', 05:37:06 INFO - 'LANGUAGE': 'en_US:en', 05:37:06 INFO - 'LOGNAME': 'cltbld', 05:37:06 INFO - 'MAIL': '/var/mail/cltbld', 05:37:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:37:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:37:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:06 INFO - 'MOZ_NO_REMOTE': '1', 05:37:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:37:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:06 INFO - 'NO_EM_RESTART': '1', 05:37:06 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:37:06 INFO - 'PWD': '/builds/slave/test-pgo', 05:37:06 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:37:06 INFO - 'SHELL': '/bin/bash', 05:37:06 INFO - 'SHLVL': '1', 05:37:06 INFO - 'TERM': 'linux', 05:37:06 INFO - 'TMOUT': '86400', 05:37:06 INFO - 'USER': 'cltbld', 05:37:06 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1457357447.524786-547682945', 05:37:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:06 INFO - '_': '/tools/buildbot/bin/python'} 05:37:06 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GCOOGTTQTRePB11bu1avvg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:37:06 INFO - mozversion application_buildid: 20160307030208 05:37:06 INFO - mozversion application_changeset: 68d3781deda0d4d58ec9877862830db89669b3a5 05:37:06 INFO - mozversion application_display_name: Nightly 05:37:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:37:06 INFO - mozversion application_name: Firefox 05:37:06 INFO - mozversion application_remotingname: firefox 05:37:06 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:37:06 INFO - mozversion application_vendor: Mozilla 05:37:06 INFO - mozversion application_version: 47.0a1 05:37:06 INFO - mozversion platform_buildid: 20160307030208 05:37:06 INFO - mozversion platform_changeset: 68d3781deda0d4d58ec9877862830db89669b3a5 05:37:06 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:37:06 INFO - mozversion platform_version: 47.0a1 05:37:06 INFO - using testdate: 1457357826 05:37:06 INFO - actual date: 1457357826 05:37:06 INFO - starting webserver on 'localhost:41246' 05:37:06 INFO - SUITE-START | Running 2 tests 05:37:06 INFO - TEST-START | dromaeo_css 05:37:06 INFO - operating with platform_type : linux_ 05:37:06 INFO - Initialising browser for dromaeo_css test... 05:37:06 INFO - TEST-INFO | started process 30851 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJJtrMh/profile http://localhost:41246/getInfo.html) 05:37:10 INFO - PROCESS | 30851 | __metrics Screen width/height:1600/1200 05:37:10 INFO - PROCESS | 30851 | colorDepth:24 05:37:10 INFO - PROCESS | 30851 | Browser inner width/height: 1024/697 05:37:10 INFO - PROCESS | 30851 | __metrics 05:37:11 INFO - PROCESS | 30851 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:37:12 INFO - TEST-INFO | 30851: exit 0 05:37:12 INFO - Browser initialized. 05:37:12 INFO - Running cycle 1/1 for dromaeo_css test... 05:37:12 INFO - TEST-INFO | started process 30946 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJJtrMh/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:37:24 INFO - PROCESS | 30946 | RSS: Main: 156995584 05:37:24 INFO - PROCESS | 30946 | 05:38:15 INFO - PROCESS | 30946 | 1457357895938 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:40:23 INFO - PROCESS | 30946 | Cycle 1(1): loaded http://localhost:41246/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41246/tests/dromaeo/cssquery-ext.html) 05:40:24 INFO - PROCESS | 30946 | RSS: Main: 254009344 05:40:24 INFO - PROCESS | 30946 | 05:43:27 INFO - PROCESS | 30946 | Cycle 1(1): loaded http://localhost:41246/tests/dromaeo/cssquery-ext.html (next: http://localhost:41246/tests/dromaeo/cssquery-jquery.html) 05:43:27 INFO - PROCESS | 30946 | RSS: Main: 239968256 05:43:27 INFO - PROCESS | 30946 | 05:46:29 INFO - PROCESS | 30946 | Cycle 1(1): loaded http://localhost:41246/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41246/tests/dromaeo/cssquery-mootools.html) 05:46:30 INFO - PROCESS | 30946 | RSS: Main: 242552832 05:46:30 INFO - PROCESS | 30946 | 05:49:31 INFO - PROCESS | 30946 | Cycle 1(1): loaded http://localhost:41246/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41246/tests/dromaeo/cssquery-prototype.html) 05:49:32 INFO - PROCESS | 30946 | RSS: Main: 202993664 05:49:32 INFO - PROCESS | 30946 | 05:52:35 INFO - PROCESS | 30946 | Cycle 1(1): loaded http://localhost:41246/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41246/tests/dromaeo/cssquery-yui.html) 05:52:35 INFO - PROCESS | 30946 | RSS: Main: 221110272 05:52:35 INFO - PROCESS | 30946 | 05:55:38 INFO - PROCESS | 30946 | Cycle 1(1): loaded http://localhost:41246/tests/dromaeo/cssquery-yui.html (next: http://localhost:41246/tests/dromaeo/cssquery-dojo.html) 05:55:38 INFO - PROCESS | 30946 | RSS: Main: 266743808 05:55:38 INFO - PROCESS | 30946 | 05:55:38 INFO - PROCESS | 30946 | __start_tp_report 05:55:38 INFO - PROCESS | 30946 | _x_x_mozilla_page_load 05:55:38 INFO - PROCESS | 30946 | _x_x_mozilla_page_load_details 05:55:38 INFO - PROCESS | 30946 | |i|pagename|runs| 05:55:38 INFO - PROCESS | 30946 | |0;dojo.html;3027.424789290035;3064.7241748242654;3096.8761249550007;3100.410921924834;3127.3432579158384;5141.254518094874;5190.766415511302;5205.115130427826;5206.349206349207;5235.502627250415;5151.793928242866;5217.86955326117;5235.083860324447;5241.95160967807;5247.291615631898;4718.834840780556;4755.5244475552345;4869.342638743778;4924.926126108111;4937.901241975158;4879.292502587123;4907.362042934431;4909.631777616675;4927.630427717918;4948.604111671058;4709.434867815867;4776.188048031843;4874.805007799684;4875.7074575525585;4891.144049791273;4767.547083027107;4790.664653474259;4797.18447863864;4812.927806082912;4847.006363695469;4745.311929770199;4777.474477807438;4800.783964721561;4813.15769740294;4830.299606557065;4978.153713868651;5018.322526458918;5106.64253502255;5106.8212612558755;5112.514311140436;5524.779008839641;5559.527440167591;5561.610687251894;5569.053260945609;5571.331440227158;5538.086215774432;5598.692071936042;5601.831945041615;5603.859903502404;5611.691356975365;5219.034478621429;5223.347081614798;5237.188235823453;5274.2879711238875;5284.894302113975;5709.3434255060365;5710.428957104256;5710.457506536873;5735.512481439041;5739.655620662774;5428.131498960226;5468.988237176135;5492.203630473559;5515.669059856422;5517.531009864127;5615.466530679579;5621.016322143691;5621.578381621394;5629.746661400247;5668.971655141698;5579.776808927598;5586.385497595261;5586.469285417878;5590.2453168821685;5590.804321848797;5525.336959564878;5542.251796007568;5586.050371436865;5597.888042239132;5624.493795558419;4202.642775364067;4208.642265407413;4216.219999300078;4238.554951730086;4247.68142389322;3801.4867992820614;3809.371453710107;3819.1406933439753;3835.3671644178958;3849.9230015400094;5145;5154.53609175176;5195.6622819516615;5248.895022099537;5283.392409872837;5470.781168753285;5486.31421072366;5495.395506494282;5500.367457742411;5512.173174023928;5104.157813960729;5104.3619547556555;5107.642465027412;5109.131447653907;5154.304168937146;4670.346151538787;4711.528847115261;4732.881677958009;4768.380110585671;4769.904601907942;5802.448767367094;5822.039363504974;5840.912386314209;5868.794592189253;5869.765209391662;5463.863403414946;5540.445955404427;5541.418151094077;5544.112941929272;5594.580406469449;5896.056630939201;5924.348321684525;5927.051671732502;5961.52307815365;5965.164876917148;5503.257060296809;5507.586930980273;5507.779688812403;5517.36550296721;5517.558595312285;5508.752106155152;5577.5537956962535;5581.665100094007;5587.608867379245;5634.661920284796;5475.6440831345835;5478.123500239943;5478.45215478449;5502.58730595215;5527.944720552743;5331.600129990344;5360.303160589098;5413;5418.891622167455;5444.891102177855;5141.742912854267;5329.866753331198;5366.275552800322;5367.194920761917;5383.515483606494;5508.91736623943;5512.641678290898;5515.806946756844;5520.06158952971;5551.666899986014;5374.059539580636;5397.8110766123;5402.432744561922;5410.026195284887;5413.945860541344 05:55:38 INFO - PROCESS | 30946 | |1;ext.html;472.4024109501481;517.2654830141202;524.997255242487;525.3485677759575;537.1325309624955;29106.563401548967;37638;37702.62297377025;37709.622903770956;38015.23969520608;40800.183996320055;41380.58619413805;41477.17045659085;41584.58415415845;41642;7464.402847772192;8537.573121343923;8749.693760718375;9994.500274986221;10179.338343007681;10159;10308.793824123513;10319.484025798718;10322.174226061898;10326.586936522568;10276.229282803783;10354.896451035505;10360.378377297386;10362.585496580128;10368.01503857136;10205.642802501914;10298.48507574622;10335.793284134275;10339.172866170687;10342.327748696349;9978.101970822589;10065.094141527297;10103.646372377005;10409.739756506073;10495.63265285719;41309.380359294635;41628.58371416277;41901.79049104766;42053.1589368214;42208.3668744969;3071.247544351626;3111.984440077808;3266.6080070391467;3353.8658453661824;3396.813175275359;29162.556692854883;29851;29896.252593685116;30069.849650751607;30077.849610751808;3278.7868788528667;3280.3439312137666;3359.8320083995704;3368.5115658229665;3451.0682115828836;284248;284830;285442;286077.9999999979;286336;61799.38200617936;61906.38093619096;62221;62242.377576224564;62288.688556556925;64772.35227647758;64804;64819.67590162019;64869.351306487275;64885;15499.225038748244;15517.146556939477;15608.609784755472;15654.9217253913;15665.68668626621;12195.817062744067;12240.387980600934;12283.69290767738;12288.877111228774;12299;19217.90391048036;20134.496637584176;20301.492462688257;20343.389698309074;20361.796382036286;6827.590344579341;6920.826979325457;6922.480813938974;6971.6862741176765;6987.301269872972;851.586980314547;852.1521086518953;855.9400841941005;859.5315553023618;1005.5022763732;28979.56530652042;30007.549886751716;30046.24884377908;30528.389432211676;30704.53943190854;889.6174644902625;906.8549032154956;985.4727720669407;1029.7734498410339;1035.6892932120334;13212.603621891358;13672.453101876012;13867.583972480841;13867.86132138686;13870.861291387158;262500;264327;265668;266369;267333;50335.74832125889;50685;50693.49306506961;50726;55893;1183.4378520652897;1242;1257.5409975358928;1257.6352857671357;1277.3868543099363;26003.60994585045;27644.58533122045;27781.861090694416;28907.855460722563;29493.705062949954;36639.63360366362;37139.628603713616;37190.25619487649;37210.44184337183;37307.6269237315;227516;229601;230177;230359;231076;28134.2966425841;32145.35709285848;32331.51502727508;32558.83720581382;32602.184945376557;38339.80830095831;38946.415803763535;39476.605233947295;39641.60358396379;39708.801455992536;32891.671083288864;33166.66833331636;33594.832025839714;33800.830995844866;36239;34872.47691284683;35556.466652999705;35744;35758.46362304516;35934;34971.65028349684;35602.8219858899;35755;35789;36113;30827;31793.94766055529;31867.043988680376;32035.519467207545;32056.839715802205;24383.26850194497;24450.388740281636;24518.264452066465;24859.12993045235;25125.623115652914 05:55:38 INFO - PROCESS | 30946 | |2;jquery.html;363.79445613228506;363.95268615080033;373.27025664825265;375.33752926085447;379.9544054713435;16853.157342132905;17403.912980435096;18674.25302987879;18676.06619669016;18677.439676809685;17490.38783642573;17891.821081789178;18062.638747225046;18067.27730890763;18073.096345182723;5299.708516031607;5579.497845193931;5587.664740115586;5600.299962504687;5600.6079574429805;4119.752814831105;5488.259085023511;5885.676287804169;6136.23297087864;6142.3550527194675;6067.696615169246;6089.269287685462;6091.208142941434;6091.512678985692;6097.908531372033;5846.561507886904;6092.964196086632;6117.969410152965;6118.235220597403;6120.112583675386;3702.38910579754;5216.921746173811;5385.030694474993;5386.515213630752;5400.513953744182;19993.700094498596;20320.28878989243;20425.69361459579;20427.5914481711;20674.483137921674;1751.3257395902542;1956.3739603326942;2132;2254.966175507369;2384.950621726452;12108.515659373614;12165.087618428654;12290;12430.502779888793;12600;1657.8590819780334;1668.2909763350528;1685.4438035448272;1697.9490615281438;1708.1715368046487;63996.68001660008;66203.3379666202;66705;67159.3284067158;67995.66002169957;9793.21654267657;9933.950330248303;10123.443210623487;10222.13111885498;10436.008579184965;12636;12878.227306361461;12881.806772898413;12900.161489503153;13356.332183390792;7681.347085497683;7770.494917830323;7915.327197188189;7917.920820791834;8047.436679432383;7722.42081843864;7783.883241751379;7869.449138560246;7997;8008.719694810654;6104.145419641254;6107.45032947028;6131.50947924165;6144.262688477412;6290.685465726787;1683.2088918208422;1733.471291256179;1734.9392771252947;1759.876808623384;1814.6280012597385;795.550513959611;863.9913600864037;884.4074470105045;914.6707185413246;929.8140371925642;16366.590835229215;16808.243629036722;17388.391406300718;17598.296068157386;17698.203580838635;922.6816748221853;929;947.9620815167316;1015.9542820573092;1064.5475672839013;9886.357386769982;10500.947495262475;10536;10565.701117526049;10598.152147828156;417076;419070;419736;419895;438428;72416.63791681008;73862.63068684623;74895.5020899579;75283.62358188284;75362.24637753662;1019.4393083803878;1048.6801525534786;1057.814882395593;1061.639042725477;1065.4992153687754;15916.602084947968;15937.282822272793;16099.517014489116;16272.837271627606;16605.50183494497;33341.83329083339;35376.29247414986;35477.467837982964;35835.462468063524;36748;49077;51394.48605513897;51471.22793158181;52022.21966670579;52335.73832130968;8096.352291816758;8116.918830811616;8236.229210719484;8301.709440169565;8542.74371768848;8710.782230444289;9815.411075335503;12058.397080146133;12992.935035324763;13139.474421023053;10602;10840.783184336111;10875.51060202277;10965.451727413438;11586.652400428;10900.509477073392;10920.2901811382;11244.325340479598;11369.715757106138;11548.249363791327;10719.89280107189;10759.838602421127;10804.459777011276;10936.125109991022;11680.591179308683;8356.206160414751;8417.873731893904;8471.364647651328;8649.61076751535;8722;10165.949170254102;11156.665300041012;11180.720481988015;11627.709307267385;11680.415979200836 05:55:38 INFO - PROCESS | 30946 | |3;mootools.html;1368.7741522648764;1445.6096853849465;1454.97817532737;1620.5219460259223;1797.05654531371;6741.494387920907;7118.928810711898;7288.271172882709;7295.4893157479;7298.81752956175;7274.781756547299;7449.068866391701;7451.776446706594;7453.55278683278;7460;1971.5071232191951;2018.1221168791549;2209.1826024371007;2238.1271304191378;2263.366257447909;2217.73387193537;2225.9777402226014;2230.018791731641;2231.040652519416;2231.6094683430415;2207.415035015722;2238.5746708125403;2245.8764767937755;2266.5693518231565;2269.3305474884864;2226.0873042052845;2232.174095584628;2245.9887700561558;2255.3684968208927;2261.9434514137115;2226.2875879718335;2227.3318004598555;2239.305815197294;2245.539664368817;2248.8875556222124;7512.661930213154;7584.4690871639;7592.126905405894;7612.086549614027;7687.769366919001;4693.859184224445;4826.0830442215865;4826.34844296019;4826.686265392738;4830.589399901012;2943.5290353543546;2953.7193966573354;3079.63044434667;3086.5215891536845;3096.9535456968165;968.4334664221439;981.40134517944;982.9162176186459;995.21875327868;1028.2082796246923;10246.026627470454;10246.743831404274;10250.641227557;10266.281360304782;10268.07587317145;4221.957780422218;4285.057287396768;4393.275109606943;4411.977940110343;4414.3157810539415;8793.692220772242;8802.339824513187;8806.823863522823;8829.072947340564;8829.514376709214;4825.252085926687;4836.903261934742;4842.927356089662;4847.636427267969;4854.393200849894;3826.215625796761;4240.088380998101;4340.674449416307;4388.100439409914;4412.6690498212765;3670.1925576373155;3746.550413950343;3746.737728359043;3765.736398452082;3816.6374194452037;1194.1402190422882;1206.9637910862689;1210.2798834693344;1220.3105245536244;1224.7856625090574;908.1327332397544;919.8712180294764;924.4360939826701;975.4050029482011;1256.3153081570565;7215.530990485601;7215.747448839265;7217.386522145676;7242.348188662941;7251.601161936144;503.9769268385184;506.4378539820796;516.8630312967067;518.8184135552602;519.7011718262014;5645.463680950304;5670.773169073191;5688.203651488795;5713.885722285614;5737.139429085671;8839.425437346552;9133.086691330947;9164.358494905426;9272.721818345326;9290.1174388433;8827.382083254111;8953.955230223808;9038.09619038091;9082.86375704365;9089.363744537952;7113.786586402416;7229.7469588564145;7244.673989670478;7287.562746235137;7304.5982470963545;6886.10480637534;6912.308769123048;6974.895376569254;7014.964925175342;7015.614141222281;7923.128455869965;8101.797455063671;8145.674173033012;8317.251447369525;8324.833503329779;8070.5964701763505;8191.631376587949;8340.124286949784;8340.457870238415;8350.164983501601;6100.664463454553;6378.52161087911;6583.44040756541;6609.4712423007;6710.530262881552;6997.160340758938;7004.369606735215;7009.2990700929495;7060.858782824212;7067.328603782633;6307.337729538516;6462.998235273541;6490.610563366213;6554.63949482783;6556.0493728410065;6099.84750381244;6159.23009623797;6214.40963108504;6307.716152773044;6375.107484952017;6482.967585162044;6498.447631951337;6536.3136870627895;6541.967290163519;6545.836354091186;6101.115338276014;6149.938500614937;6152.538559607958;6157.4458298753325;6282.2147231596055;6304.779332723333;6309.842253943688;6333.556651034383;6354.4598709108395;6381.7128229228865 05:55:38 INFO - PROCESS | 30946 | |4;prototype.html;345.3386764346277;347.17892184982526;348.2599476113259;349.25782711737565;355.03784743345517;5912.704364781765;5914.881702365956;5938.257717785277;5962.433568810967;5969.462748352647;5895.793647222348;5897.20387747654;5899.643082091122;5901.527877769779;5908.291005079396;4377.299632058871;4476.306172543244;4541.818327266906;4575.771211439432;4635.304704294357;4546.568076032771;4574.83988060418;4581.65637577183;4582.564656357641;4586.518415566367;4553.225951588238;4556.476005259405;4578;4581.1753884300815;4582.587567118959;4293.935590966138;4435.84474543391;4488.842890498817;4497.9100417991785;4536.614387777043;3967.206558688274;3967.940480892789;3971.0667993021616;3975.2447035063533;3976.8608098716404;5649.6327738696855;5651.1523271509195;5652.434756524356;5656.519195868356;5657.2928383952;5267.446918073585;5271.499207575274;5273.393559740641;5278.683279003272;5293;6283.937160628427;6287.591306565058;6292.1820163378925;6292.528060395489;6297.716602752887;4213;4325.8485952991805;4346.500152482474;4415.116976604692;4425.09285596452;6501.544891857572;6546.050822630692;6571.835704107436;6584.275729669685;6590.373914478117;4462.174497717932;4467.039586488921;4468.486124095705;4470.262406702923;4471.686981911235;4527.253003254426;4532.297493888453;4532.79602417892;4534.6372290216705;4538.546145385501;5256.106461901486;5258.316418865523;5260.605454590921;5261.0793111205385;5265.368155821326;6193.907091393633;6246.906296405557;6338.207724034496;6348.730253949137;6351.9682401588625;1560.6956643454644;1566.4908904606048;1584.0574857959725;1586.3178833101647;1588.6584384357188;958.5494817435933;1031.7369070886875;1034.896510348959;1048.8741351037925;1065.6217042949797;5896.233489646319;5942.554308426799;5957.553183511254;5961;5965.522758179335;6443.5167362448;6454.806355809239;6458;6458.6770661466735;6462.224533055969;5923.348431672513;5933.554983376264;5934.910976335358;5939.613925094855;5943.8216853493595;3441.2257242120822;3473.4442489201606;3480.6693364130365;3482.059843842199;3486.6687664671817;6680.131582894192;6842.5552339098795;6848.246692863781;6921.2732663069655;6968.128983877015;6674.83312917181;6705;6720.798376048726;6725.798226053226;6732.798016059526;6930.237673855871;6947.096877405905;6947.548409353376;6952.5480843745;6955.269696681877;6492.577982431316;6529.412352888263;6534.542582019213;6536.084948107174;6541.70562324706;6273.341299163522;6448.419642232222;6487.967560162358;6489.707963141765;6490.188726409199;6931.306869313028;6952.339527744856;6971.755988540377;6981.79054628362;6990.895136573057;4437.445319335083;4507.887302817456;4508.594226519629;4509.053098849278;4517.616002639812;6585.934140658532;6591.209054913249;6593.736250549924;6597.50518711089;6599.373059559334;6261.749530018748;6369.522285828489;6371.171747672773;6381.457576106083;6382.042693595998;6299.874002520016;6372.55392122547;6379.457746091634;6383.648899310582;6388.073729309317;6244.250689917239;6264.436200741955;6269.467095296768;6272.8431789203805;6281;6340;6401.327860574573;6408.134901788386;6409.262934762562;6413.8396540085005;6006.429389208019;6054.182685337423;6234.657093859882;6242.65665388408;6250.656213908279 05:55:38 INFO - PROCESS | 30946 | |5;yui.html;674.5986138247742;688.0607970120786;699.1156187422911;703.4688809948489;706.4454403293415;13778.793318100237;13891.305434728274;13904.235267060307;13923.930380348109;13945.163290202583;11604.129690273243;13169.078164528486;13188;13190.274534900576;13214.933925330384;836.7615229659564;844.6494704697543;845.8054647431095;846.5047946951041;849.5454931611589;850.6342272822684;854.3250831842837;857.5969294431607;859.7721603775004;861.9094995025526;894.6645008121955;895.5253715530779;896.6458248991645;897.2104547997753;897.2149369301861;726.96728647211;876.8071024374627;876.9649214031431;877.5305211711767;877.6006916852848;642.7172044300493;644.262319644005;644.6228956060663;644.78399736088;645.0356716708504;13436.193828370231;13448.529301474498;13545.661358466019;13559.59321220365;13571.253581053137;11277;11599.304041757438;11642.417879106095;11788.882111178864;11891.881081189164;9321.860172097424;9357.204637605812;9401.294902882311;9500.097490738437;9619.230461563058;3109.9533506997413;3143.2770462793455;3165.2878102427;3231.8545665445113;3233.2401885556874;47639.523604763854;48234.51765482335;48347.51652483465;48568;48675.513244867456;8761.518116503654;8887.244584210286;8944.910550894409;8953.238974687225;9273.675421360354;17609.647807043788;17612.119394030247;17638;17801.554961126076;17826;6637.878591445285;6863.142107236596;7048.189458212269;7071.575705457689;7243.3340331724;4009.7393669411395;4015;4074.083331250445;4107.301758701028;4167.687423443193;3047.7104675055834;3048.3141293209296;3057.3121047764075;3065.5095184770776;3099.9535006974916;504.06747517093083;521.3144714700157;525.4141632080203;547.6221407228999;561.9494245517923;536.3831593667314;545.3020134228194;559.5467671186352;566.5156291370901;572.074439079525;7842.176571459914;7848.960755196302;7886.684532618746;7918;8029.919700803034;519.5531842615347;523.2857149990311;539.7301349325337;542.0838782457633;542.5659472422126;3484.4773284007097;3666.8816011116865;3668.2296717689583;3760.0599850037493;3802.524684414448;52411;53528.46471535235;54201.45798542043;54301;54344.72827635916;48028.27957580569;49191.508084919406;49918.25122623164;49957.25064124041;50263.49736502661;44368.778156109016;45129;45443.54556454459;47460;48265.75867120642;7012.228654848064;7042.964785176041;7044.577325360495;7164.211936687065;7207.783766487014;32907.341853163285;33618.15954601154;34495;35109.297814043064;35328.29343413066;38365.80817095897;39376.803115984236;42575.36136957886;44311.33532996943;44526.77736611296;9921.454320012468;10019.499025048864;10138.290319677551;10154.238432117769;10162.085412312927;10723.356598604109;10895;10925.726856828325;10998;11380.54477820911;10181.694549163536;10292.125169360688;10442.843357349799;10506.264561480928;10870.945645271722;10435.895641043797;10576.629817956335;10581.735456613646;10854.185936054986;10899;10024;10050.09549140581;10070.446125462877;10213.540390682585;10335.276530643083;7913.9604301978125;7930.31862975843;8229.094799572162;8236.50580965144;8400.537970411686;7874.291313781787;8327.669433295785;8643.092475290005;8787.868181977403;8854 05:55:38 INFO - PROCESS | 30946 | __end_tp_report 05:55:38 INFO - PROCESS | 30946 | __start_cc_report 05:55:38 INFO - PROCESS | 30946 | _x_x_mozilla_cycle_collect,811 05:55:38 INFO - PROCESS | 30946 | __end_cc_report 05:55:38 INFO - PROCESS | 30946 | __startTimestamp1457358938633__endTimestamp 05:55:38 INFO - PROCESS | 30946 | 05:55:38 INFO - PROCESS | 30946 | ------- Summary: start ------- 05:55:38 INFO - PROCESS | 30946 | Number of tests: 6 05:55:38 INFO - PROCESS | 30946 | 05:55:38 INFO - PROCESS | 30946 | [#0] dojo.html Cycles:165 Average:5189.47 Median:5383.52 stddev:581.09 (10.8%) stddev-sans-first:557.57 05:55:38 INFO - PROCESS | 30946 | Values: 3027.4 3064.7 3096.9 3100.4 3127.3 5141.3 5190.8 5205.1 5206.3 5235.5 5151.8 5217.9 5235.1 5242.0 5247.3 4718.8 4755.5 4869.3 4924.9 4937.9 4879.3 4907.4 4909.6 4927.6 4948.6 4709.4 4776.2 4874.8 4875.7 4891.1 4767.5 4790.7 4797.2 4812.9 4847.0 4745.3 4777.5 4800.8 4813.2 4830.3 4978.2 5018.3 5106.6 5106.8 5112.5 5524.8 5559.5 5561.6 5569.1 5571.3 5538.1 5598.7 5601.8 5603.9 5611.7 5219.0 5223.3 5237.2 5274.3 5284.9 5709.3 5710.4 5710.5 5735.5 5739.7 5428.1 5469.0 5492.2 5515.7 5517.5 5615.5 5621.0 5621.6 5629.7 5669.0 5579.8 5586.4 5586.5 5590.2 5590.8 5525.3 5542.3 5586.1 5597.9 5624.5 4202.6 4208.6 4216.2 4238.6 4247.7 3801.5 3809.4 3819.1 3835.4 3849.9 5145.0 5154.5 5195.7 5248.9 5283.4 5470.8 5486.3 5495.4 5500.4 5512.2 5104.2 5104.4 5107.6 5109.1 5154.3 4670.3 4711.5 4732.9 4768.4 4769.9 5802.4 5822.0 5840.9 5868.8 5869.8 5463.9 5540.4 5541.4 5544.1 5594.6 5896.1 5924.3 5927.1 5961.5 5965.2 5503.3 5507.6 5507.8 5517.4 5517.6 5508.8 5577.6 5581.7 5587.6 5634.7 5475.6 5478.1 5478.5 5502.6 5527.9 5331.6 5360.3 5413.0 5418.9 5444.9 5141.7 5329.9 5366.3 5367.2 5383.5 5508.9 5512.6 5515.8 5520.1 5551.7 5374.1 5397.8 5402.4 5410.0 5413.9 05:55:38 INFO - PROCESS | 30946 | 05:55:38 INFO - PROCESS | 30946 | [#1] ext.html Cycles:180 Average:43453.29 Median:32046.18 stddev:67986.00 (212.2%) stddev-sans-first:68100.12 05:55:38 INFO - PROCESS | 30946 | Values: 472.4 517.3 525.0 525.3 537.1 29106.6 37638.0 37702.6 37709.6 38015.2 40800.2 41380.6 41477.2 41584.6 41642.0 7464.4 8537.6 8749.7 9994.5 10179.3 10159.0 10308.8 10319.5 10322.2 10326.6 10276.2 10354.9 10360.4 10362.6 10368.0 10205.6 10298.5 10335.8 10339.2 10342.3 9978.1 10065.1 10103.6 10409.7 10495.6 41309.4 41628.6 41901.8 42053.2 42208.4 3071.2 3112.0 3266.6 3353.9 3396.8 29162.6 29851.0 29896.3 30069.8 30077.8 3278.8 3280.3 3359.8 3368.5 3451.1 284248.0 284830.0 285442.0 286078.0 286336.0 61799.4 61906.4 62221.0 62242.4 62288.7 64772.4 64804.0 64819.7 64869.4 64885.0 15499.2 15517.1 15608.6 15654.9 15665.7 12195.8 12240.4 12283.7 12288.9 12299.0 19217.9 20134.5 20301.5 20343.4 20361.8 6827.6 6920.8 6922.5 6971.7 6987.3 851.6 852.2 855.9 859.5 1005.5 28979.6 30007.5 30046.2 30528.4 30704.5 889.6 906.9 985.5 1029.8 1035.7 13212.6 13672.5 13867.6 13867.9 13870.9 262500.0 264327.0 265668.0 266369.0 267333.0 50335.7 50685.0 50693.5 50726.0 55893.0 1183.4 1242.0 1257.5 1257.6 1277.4 26003.6 27644.6 27781.9 28907.9 29493.7 36639.6 37139.6 37190.3 37210.4 37307.6 227516.0 229601.0 230177.0 230359.0 231076.0 28134.3 32145.4 32331.5 32558.8 32602.2 38339.8 38946.4 39476.6 39641.6 39708.8 32891.7 33166.7 33594.8 33800.8 36239.0 34872.5 35556.5 35744.0 35758.5 35934.0 34971.7 35602.8 35755.0 35789.0 36113.0 30827.0 31793.9 31867.0 32035.5 32056.8 24383.3 24450.4 24518.3 24859.1 25125.6 05:55:38 INFO - PROCESS | 30946 | 05:55:38 INFO - PROCESS | 30946 | [#2] jquery.html Cycles:180 Average:25474.24 Median:18099.63 stddev:69428.66 (383.6%) stddev-sans-first:69597.83 05:55:38 INFO - PROCESS | 30946 | Values: 363.8 364.0 373.3 375.3 380.0 16853.2 17403.9 18674.3 18676.1 18677.4 17490.4 17891.8 18062.6 18067.3 18073.1 5299.7 5579.5 5587.7 5600.3 5600.6 4119.8 5488.3 5885.7 6136.2 6142.4 6067.7 6089.3 6091.2 6091.5 6097.9 5846.6 6093.0 6118.0 6118.2 6120.1 3702.4 5216.9 5385.0 5386.5 5400.5 19993.7 20320.3 20425.7 20427.6 20674.5 1751.3 1956.4 2132.0 2255.0 2385.0 12108.5 12165.1 12290.0 12430.5 12600.0 1657.9 1668.3 1685.4 1697.9 1708.2 63996.7 66203.3 66705.0 67159.3 67995.7 9793.2 9934.0 10123.4 10222.1 10436.0 12636.0 12878.2 12881.8 12900.2 13356.3 7681.3 7770.5 7915.3 7917.9 8047.4 7722.4 7783.9 7869.4 7997.0 8008.7 6104.1 6107.5 6131.5 6144.3 6290.7 1683.2 1733.5 1734.9 1759.9 1814.6 795.6 864.0 884.4 914.7 929.8 16366.6 16808.2 17388.4 17598.3 17698.2 922.7 929.0 948.0 1016.0 1064.5 9886.4 10500.9 10536.0 10565.7 10598.2 417076.0 419070.0 419736.0 419895.0 438428.0 72416.6 73862.6 74895.5 75283.6 75362.2 1019.4 1048.7 1057.8 1061.6 1065.5 15916.6 15937.3 16099.5 16272.8 16605.5 33341.8 35376.3 35477.5 35835.5 36748.0 49077.0 51394.5 51471.2 52022.2 52335.7 8096.4 8116.9 8236.2 8301.7 8542.7 8710.8 9815.4 12058.4 12992.9 13139.5 10602.0 10840.8 10875.5 10965.5 11586.7 10900.5 10920.3 11244.3 11369.7 11548.2 10719.9 10759.8 10804.5 10936.1 11680.6 8356.2 8417.9 8471.4 8649.6 8722.0 10165.9 11156.7 11180.7 11627.7 11680.4 05:55:38 INFO - PROCESS | 30946 | 05:55:38 INFO - PROCESS | 30946 | [#3] mootools.html Cycles:180 Average:5263.87 Median:6293.50 stddev:2717.74 (43.2%) stddev-sans-first:2709.59 05:55:38 INFO - PROCESS | 30946 | Values: 1368.8 1445.6 1455.0 1620.5 1797.1 6741.5 7118.9 7288.3 7295.5 7298.8 7274.8 7449.1 7451.8 7453.6 7460.0 1971.5 2018.1 2209.2 2238.1 2263.4 2217.7 2226.0 2230.0 2231.0 2231.6 2207.4 2238.6 2245.9 2266.6 2269.3 2226.1 2232.2 2246.0 2255.4 2261.9 2226.3 2227.3 2239.3 2245.5 2248.9 7512.7 7584.5 7592.1 7612.1 7687.8 4693.9 4826.1 4826.3 4826.7 4830.6 2943.5 2953.7 3079.6 3086.5 3097.0 968.4 981.4 982.9 995.2 1028.2 10246.0 10246.7 10250.6 10266.3 10268.1 4222.0 4285.1 4393.3 4412.0 4414.3 8793.7 8802.3 8806.8 8829.1 8829.5 4825.3 4836.9 4842.9 4847.6 4854.4 3826.2 4240.1 4340.7 4388.1 4412.7 3670.2 3746.6 3746.7 3765.7 3816.6 1194.1 1207.0 1210.3 1220.3 1224.8 908.1 919.9 924.4 975.4 1256.3 7215.5 7215.7 7217.4 7242.3 7251.6 504.0 506.4 516.9 518.8 519.7 5645.5 5670.8 5688.2 5713.9 5737.1 8839.4 9133.1 9164.4 9272.7 9290.1 8827.4 8954.0 9038.1 9082.9 9089.4 7113.8 7229.7 7244.7 7287.6 7304.6 6886.1 6912.3 6974.9 7015.0 7015.6 7923.1 8101.8 8145.7 8317.3 8324.8 8070.6 8191.6 8340.1 8340.5 8350.2 6100.7 6378.5 6583.4 6609.5 6710.5 6997.2 7004.4 7009.3 7060.9 7067.3 6307.3 6463.0 6490.6 6554.6 6556.0 6099.8 6159.2 6214.4 6307.7 6375.1 6483.0 6498.4 6536.3 6542.0 6545.8 6101.1 6149.9 6152.5 6157.4 6282.2 6304.8 6309.8 6333.6 6354.5 6381.7 05:55:38 INFO - PROCESS | 30946 | 05:55:38 INFO - PROCESS | 30946 | [#4] prototype.html Cycles:180 Average:5289.99 Median:5938.94 stddev:1612.54 (27.2%) stddev-sans-first:1573.77 05:55:38 INFO - PROCESS | 30946 | Values: 345.3 347.2 348.3 349.3 355.0 5912.7 5914.9 5938.3 5962.4 5969.5 5895.8 5897.2 5899.6 5901.5 5908.3 4377.3 4476.3 4541.8 4575.8 4635.3 4546.6 4574.8 4581.7 4582.6 4586.5 4553.2 4556.5 4578.0 4581.2 4582.6 4293.9 4435.8 4488.8 4497.9 4536.6 3967.2 3967.9 3971.1 3975.2 3976.9 5649.6 5651.2 5652.4 5656.5 5657.3 5267.4 5271.5 5273.4 5278.7 5293.0 6283.9 6287.6 6292.2 6292.5 6297.7 4213.0 4325.8 4346.5 4415.1 4425.1 6501.5 6546.1 6571.8 6584.3 6590.4 4462.2 4467.0 4468.5 4470.3 4471.7 4527.3 4532.3 4532.8 4534.6 4538.5 5256.1 5258.3 5260.6 5261.1 5265.4 6193.9 6246.9 6338.2 6348.7 6352.0 1560.7 1566.5 1584.1 1586.3 1588.7 958.5 1031.7 1034.9 1048.9 1065.6 5896.2 5942.6 5957.6 5961.0 5965.5 6443.5 6454.8 6458.0 6458.7 6462.2 5923.3 5933.6 5934.9 5939.6 5943.8 3441.2 3473.4 3480.7 3482.1 3486.7 6680.1 6842.6 6848.2 6921.3 6968.1 6674.8 6705.0 6720.8 6725.8 6732.8 6930.2 6947.1 6947.5 6952.5 6955.3 6492.6 6529.4 6534.5 6536.1 6541.7 6273.3 6448.4 6488.0 6489.7 6490.2 6931.3 6952.3 6971.8 6981.8 6990.9 4437.4 4507.9 4508.6 4509.1 4517.6 6585.9 6591.2 6593.7 6597.5 6599.4 6261.7 6369.5 6371.2 6381.5 6382.0 6299.9 6372.6 6379.5 6383.6 6388.1 6244.3 6264.4 6269.5 6272.8 6281.0 6340.0 6401.3 6408.1 6409.3 6413.8 6006.4 6054.2 6234.7 6242.7 6250.7 05:55:38 INFO - PROCESS | 30946 | 05:55:38 INFO - PROCESS | 30946 | [#5] yui.html Cycles:180 Average:13142.59 Median:49554.88 stddev:15480.13 (31.2%) stddev-sans-first:15495.25 05:55:38 INFO - PROCESS | 30946 | Values: 674.6 688.1 699.1 703.5 706.4 13778.8 13891.3 13904.2 13923.9 13945.2 11604.1 13169.1 13188.0 13190.3 13214.9 836.8 844.6 845.8 846.5 849.5 850.6 854.3 857.6 859.8 861.9 894.7 895.5 896.6 897.2 897.2 727.0 876.8 877.0 877.5 877.6 642.7 644.3 644.6 644.8 645.0 13436.2 13448.5 13545.7 13559.6 13571.3 11277.0 11599.3 11642.4 11788.9 11891.9 9321.9 9357.2 9401.3 9500.1 9619.2 3110.0 3143.3 3165.3 3231.9 3233.2 47639.5 48234.5 48347.5 48568.0 48675.5 8761.5 8887.2 8944.9 8953.2 9273.7 17609.6 17612.1 17638.0 17801.6 17826.0 6637.9 6863.1 7048.2 7071.6 7243.3 4009.7 4015.0 4074.1 4107.3 4167.7 3047.7 3048.3 3057.3 3065.5 3100.0 504.1 521.3 525.4 547.6 561.9 536.4 545.3 559.5 566.5 572.1 7842.2 7849.0 7886.7 7918.0 8029.9 519.6 523.3 539.7 542.1 542.6 3484.5 3666.9 3668.2 3760.1 3802.5 52411.0 53528.5 54201.5 54301.0 54344.7 48028.3 49191.5 49918.3 49957.3 50263.5 44368.8 45129.0 45443.5 47460.0 48265.8 7012.2 7043.0 7044.6 7164.2 7207.8 32907.3 33618.2 34495.0 35109.3 35328.3 38365.8 39376.8 42575.4 44311.3 44526.8 9921.5 10019.5 10138.3 10154.2 10162.1 10723.4 10895.0 10925.7 10998.0 11380.5 10181.7 10292.1 10442.8 10506.3 10870.9 10435.9 10576.6 10581.7 10854.2 10899.0 10024.0 10050.1 10070.4 10213.5 10335.3 7914.0 7930.3 8229.1 8236.5 8400.5 7874.3 8327.7 8643.1 8787.9 8854.0 05:55:38 INFO - PROCESS | 30946 | -------- Summary: end -------- 05:55:38 INFO - PROCESS | 30946 | 05:55:39 INFO - TEST-INFO | 30946: exit 0 05:55:39 INFO - TEST-OK | dromaeo_css | took 1113034ms 05:55:39 INFO - TEST-START | kraken 05:55:39 INFO - operating with platform_type : linux_ 05:55:39 INFO - Initialising browser for kraken test... 05:55:39 INFO - TEST-INFO | started process 31135 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpExH6mg/profile http://localhost:41246/getInfo.html) 05:55:43 INFO - PROCESS | 31135 | __metrics Screen width/height:1600/1200 05:55:43 INFO - PROCESS | 31135 | colorDepth:24 05:55:43 INFO - PROCESS | 31135 | Browser inner width/height: 1024/697 05:55:43 INFO - PROCESS | 31135 | __metrics 05:55:45 INFO - PROCESS | 31135 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:55:45 INFO - TEST-INFO | 31135: exit 0 05:55:45 INFO - Browser initialized. 05:55:45 INFO - Running cycle 1/1 for kraken test... 05:55:45 INFO - TEST-INFO | started process 31220 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpExH6mg/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:55:57 INFO - PROCESS | 31220 | RSS: Main: 156540928 05:55:57 INFO - PROCESS | 31220 | 05:56:00 INFO - PROCESS | 31220 | Cycle 1(1): loaded http://localhost:41246/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41246/tests/kraken/driver.html?testName=audio-beat-detection) 05:56:00 INFO - PROCESS | 31220 | RSS: Main: 199802880 05:56:00 INFO - PROCESS | 31220 | 05:56:03 INFO - PROCESS | 31220 | Cycle 1(1): loaded http://localhost:41246/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41246/tests/kraken/driver.html?testName=audio-dft) 05:56:04 INFO - PROCESS | 31220 | RSS: Main: 189480960 05:56:04 INFO - PROCESS | 31220 | 05:56:07 INFO - PROCESS | 31220 | Cycle 1(1): loaded http://localhost:41246/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41246/tests/kraken/driver.html?testName=audio-fft) 05:56:07 INFO - PROCESS | 31220 | RSS: Main: 172781568 05:56:07 INFO - PROCESS | 31220 | 05:56:09 INFO - PROCESS | 31220 | Cycle 1(1): loaded http://localhost:41246/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41246/tests/kraken/driver.html?testName=audio-oscillator) 05:56:10 INFO - PROCESS | 31220 | RSS: Main: 173535232 05:56:10 INFO - PROCESS | 31220 | 05:56:12 INFO - PROCESS | 31220 | Cycle 1(1): loaded http://localhost:41246/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41246/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:56:13 INFO - PROCESS | 31220 | RSS: Main: 175153152 05:56:13 INFO - PROCESS | 31220 | 05:56:16 INFO - PROCESS | 31220 | Cycle 1(1): loaded http://localhost:41246/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41246/tests/kraken/driver.html?testName=imaging-darkroom) 05:56:16 INFO - PROCESS | 31220 | RSS: Main: 176963584 05:56:16 INFO - PROCESS | 31220 | 05:56:20 INFO - PROCESS | 31220 | Cycle 1(1): loaded http://localhost:41246/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41246/tests/kraken/driver.html?testName=imaging-desaturate) 05:56:20 INFO - PROCESS | 31220 | RSS: Main: 178380800 05:56:20 INFO - PROCESS | 31220 | 05:56:23 INFO - PROCESS | 31220 | Cycle 1(1): loaded http://localhost:41246/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41246/tests/kraken/driver.html?testName=json-parse-financial) 05:56:24 INFO - PROCESS | 31220 | RSS: Main: 178188288 05:56:24 INFO - PROCESS | 31220 | 05:56:25 INFO - PROCESS | 31220 | Cycle 1(1): loaded http://localhost:41246/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41246/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:56:26 INFO - PROCESS | 31220 | RSS: Main: 187424768 05:56:26 INFO - PROCESS | 31220 | 05:56:27 INFO - PROCESS | 31220 | Cycle 1(1): loaded http://localhost:41246/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41246/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:56:28 INFO - PROCESS | 31220 | RSS: Main: 183775232 05:56:28 INFO - PROCESS | 31220 | 05:56:30 INFO - PROCESS | 31220 | Cycle 1(1): loaded http://localhost:41246/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41246/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:56:31 INFO - PROCESS | 31220 | RSS: Main: 199573504 05:56:31 INFO - PROCESS | 31220 | 05:56:33 INFO - PROCESS | 31220 | Cycle 1(1): loaded http://localhost:41246/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:56:34 INFO - PROCESS | 31220 | RSS: Main: 206548992 05:56:34 INFO - PROCESS | 31220 | 05:56:36 INFO - PROCESS | 31220 | Cycle 1(1): loaded http://localhost:41246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:56:37 INFO - PROCESS | 31220 | RSS: Main: 201224192 05:56:37 INFO - PROCESS | 31220 | 05:56:39 INFO - PROCESS | 31220 | Cycle 1(1): loaded http://localhost:41246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41246/tests/kraken/driver.html?testName=ai-astar) 05:56:39 INFO - PROCESS | 31220 | RSS: Main: 262000640 05:56:39 INFO - PROCESS | 31220 | 05:56:39 INFO - PROCESS | 31220 | __start_tp_report 05:56:39 INFO - PROCESS | 31220 | _x_x_mozilla_page_load 05:56:39 INFO - PROCESS | 31220 | _x_x_mozilla_page_load_details 05:56:39 INFO - PROCESS | 31220 | |i|pagename|runs| 05:56:39 INFO - PROCESS | 31220 | |0;ai-astar;108;110;104;111;110;110;100;110;109;110 05:56:39 INFO - PROCESS | 31220 | |1;audio-beat-detection;157;134;154;174;131;157;160;128;174;127 05:56:39 INFO - PROCESS | 31220 | |2;audio-dft;162;162;160;160;161;162;161;164;163;162 05:56:39 INFO - PROCESS | 31220 | |3;audio-fft;76;76;103;101;75;73;75;116;98;74 05:56:39 INFO - PROCESS | 31220 | |4;audio-oscillator;93;94;137;93;95;94;147;94;93;143 05:56:39 INFO - PROCESS | 31220 | |5;imaging-gaussian-blur;116;117;117;117;116;116;117;117;116;117 05:56:39 INFO - PROCESS | 31220 | |6;imaging-darkroom;146;145;144;144;145;145;146;145;145;145 05:56:39 INFO - PROCESS | 31220 | |7;imaging-desaturate;95;96;95;96;96;95;95;95;95;96 05:56:39 INFO - PROCESS | 31220 | |8;json-parse-financial;56;57;56;57;57;57;56;64;54;53 05:56:39 INFO - PROCESS | 31220 | |9;json-stringify-tinderbox;68;68;69;68;68;69;69;69;69;69 05:56:39 INFO - PROCESS | 31220 | |10;stanford-crypto-aes;81;83;83;91;82;83;81;83;82;82 05:56:39 INFO - PROCESS | 31220 | |11;stanford-crypto-ccm;124;121;124;115;111;114;114;112;115;114 05:56:39 INFO - PROCESS | 31220 | |12;stanford-crypto-pbkdf2;160;147;144;146;146;140;149;150;159;149 05:56:39 INFO - PROCESS | 31220 | |13;stanford-crypto-sha256-iterative;67;70;71;70;68;69;67;71;68;66 05:56:39 INFO - PROCESS | 31220 | __end_tp_report 05:56:39 INFO - PROCESS | 31220 | __start_cc_report 05:56:39 INFO - PROCESS | 31220 | _x_x_mozilla_cycle_collect,1090 05:56:39 INFO - PROCESS | 31220 | __end_cc_report 05:56:39 INFO - PROCESS | 31220 | __startTimestamp1457358999349__endTimestamp 05:56:39 INFO - PROCESS | 31220 | 05:56:39 INFO - PROCESS | 31220 | ------- Summary: start ------- 05:56:39 INFO - PROCESS | 31220 | Number of tests: 14 05:56:39 INFO - PROCESS | 31220 | 05:56:39 INFO - PROCESS | 31220 | [#0] ai-astar Cycles:10 Average:108.20 Median:110.00 stddev:3.49 (3.2%) stddev-sans-first:3.70 05:56:39 INFO - PROCESS | 31220 | Values: 108.0 110.0 104.0 111.0 110.0 110.0 100.0 110.0 109.0 110.0 05:56:39 INFO - PROCESS | 31220 | 05:56:39 INFO - PROCESS | 31220 | [#1] audio-beat-detection Cycles:10 Average:149.60 Median:157.00 stddev:18.24 (11.6%) stddev-sans-first:19.15 05:56:39 INFO - PROCESS | 31220 | Values: 157.0 134.0 154.0 174.0 131.0 157.0 160.0 128.0 174.0 127.0 05:56:39 INFO - PROCESS | 31220 | 05:56:39 INFO - PROCESS | 31220 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.25 (0.8%) stddev-sans-first:1.32 05:56:39 INFO - PROCESS | 31220 | Values: 162.0 162.0 160.0 160.0 161.0 162.0 161.0 164.0 163.0 162.0 05:56:39 INFO - PROCESS | 31220 | 05:56:39 INFO - PROCESS | 31220 | [#3] audio-fft Cycles:10 Average:86.70 Median:75.00 stddev:16.01 (21.4%) stddev-sans-first:16.51 05:56:39 INFO - PROCESS | 31220 | Values: 76.0 76.0 103.0 101.0 75.0 73.0 75.0 116.0 98.0 74.0 05:56:39 INFO - PROCESS | 31220 | 05:56:39 INFO - PROCESS | 31220 | [#4] audio-oscillator Cycles:10 Average:108.30 Median:93.50 stddev:23.61 (25.3%) stddev-sans-first:24.39 05:56:39 INFO - PROCESS | 31220 | Values: 93.0 94.0 137.0 93.0 95.0 94.0 147.0 94.0 93.0 143.0 05:56:39 INFO - PROCESS | 31220 | 05:56:39 INFO - PROCESS | 31220 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 05:56:39 INFO - PROCESS | 31220 | Values: 116.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 116.0 117.0 05:56:39 INFO - PROCESS | 31220 | 05:56:39 INFO - PROCESS | 31220 | [#6] imaging-darkroom Cycles:10 Average:145.00 Median:145.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 05:56:39 INFO - PROCESS | 31220 | Values: 146.0 145.0 144.0 144.0 145.0 145.0 146.0 145.0 145.0 145.0 05:56:39 INFO - PROCESS | 31220 | 05:56:39 INFO - PROCESS | 31220 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 05:56:39 INFO - PROCESS | 31220 | Values: 95.0 96.0 95.0 96.0 96.0 95.0 95.0 95.0 95.0 96.0 05:56:39 INFO - PROCESS | 31220 | 05:56:39 INFO - PROCESS | 31220 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:57.00 stddev:2.91 (5.1%) stddev-sans-first:3.07 05:56:39 INFO - PROCESS | 31220 | Values: 56.0 57.0 56.0 57.0 57.0 57.0 56.0 64.0 54.0 53.0 05:56:39 INFO - PROCESS | 31220 | 05:56:39 INFO - PROCESS | 31220 | [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:69.00 stddev:0.52 (0.7%) stddev-sans-first:0.50 05:56:39 INFO - PROCESS | 31220 | Values: 68.0 68.0 69.0 68.0 68.0 69.0 69.0 69.0 69.0 69.0 05:56:39 INFO - PROCESS | 31220 | 05:56:39 INFO - PROCESS | 31220 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:83.00 stddev:2.88 (3.5%) stddev-sans-first:2.96 05:56:39 INFO - PROCESS | 31220 | Values: 81.0 83.0 83.0 91.0 82.0 83.0 81.0 83.0 82.0 82.0 05:56:39 INFO - PROCESS | 31220 | 05:56:39 INFO - PROCESS | 31220 | [#11] stanford-crypto-ccm Cycles:10 Average:116.40 Median:115.00 stddev:4.79 (4.2%) stddev-sans-first:4.22 05:56:39 INFO - PROCESS | 31220 | Values: 124.0 121.0 124.0 115.0 111.0 114.0 114.0 112.0 115.0 114.0 05:56:39 INFO - PROCESS | 31220 | 05:56:39 INFO - PROCESS | 31220 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.00 Median:149.00 stddev:6.24 (4.2%) stddev-sans-first:5.19 05:56:39 INFO - PROCESS | 31220 | Values: 160.0 147.0 144.0 146.0 146.0 140.0 149.0 150.0 159.0 149.0 05:56:39 INFO - PROCESS | 31220 | 05:56:39 INFO - PROCESS | 31220 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.50 stddev:1.77 (2.5%) stddev-sans-first:1.76 05:56:39 INFO - PROCESS | 31220 | Values: 67.0 70.0 71.0 70.0 68.0 69.0 67.0 71.0 68.0 66.0 05:56:39 INFO - PROCESS | 31220 | -------- Summary: end -------- 05:56:39 INFO - PROCESS | 31220 | 05:56:40 INFO - TEST-INFO | 31220: exit 0 05:56:40 INFO - TEST-OK | kraken | took 61015ms 05:56:40 INFO - SUITE-END | took 1174s 05:56:40 INFO - Completed test suite (00:19:34) 05:56:40 INFO - javascript benchmark 05:56:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3027.424789290035, 3064.7241748242654, 3096.8761249550007, 3100.410921924834, 3127.3432579158384, 5141.254518094874, 5190.766415511302, 5205.115130427826, 5206.349206349207, 5235.502627250415, 5151.793928242866, 5217.86955326117, 5235.083860324447, 5241.95160967807, 5247.291615631898, 4718.834840780556, 4755.5244475552345, 4869.342638743778, 4924.926126108111, 4937.901241975158, 4879.292502587123, 4907.362042934431, 4909.631777616675, 4927.630427717918, 4948.604111671058, 4709.434867815867, 4776.188048031843, 4874.805007799684, 4875.7074575525585, 4891.144049791273, 4767.547083027107, 4790.664653474259, 4797.18447863864, 4812.927806082912, 4847.006363695469, 4745.311929770199, 4777.474477807438, 4800.783964721561, 4813.15769740294, 4830.299606557065, 4978.153713868651, 5018.322526458918, 5106.64253502255, 5106.8212612558755, 5112.514311140436, 5524.779008839641, 5559.527440167591, 5561.610687251894, 5569.053260945609, 5571.331440227158, 5538.086215774432, 5598.692071936042, 5601.831945041615, 5603.859903502404, 5611.691356975365, 5219.034478621429, 5223.347081614798, 5237.188235823453, 5274.2879711238875, 5284.894302113975, 5709.3434255060365, 5710.428957104256, 5710.457506536873, 5735.512481439041, 5739.655620662774, 5428.131498960226, 5468.988237176135, 5492.203630473559, 5515.669059856422, 5517.531009864127, 5615.466530679579, 5621.016322143691, 5621.578381621394, 5629.746661400247, 5668.971655141698, 5579.776808927598, 5586.385497595261, 5586.469285417878, 5590.2453168821685, 5590.804321848797, 5525.336959564878, 5542.251796007568, 5586.050371436865, 5597.888042239132, 5624.493795558419, 4202.642775364067, 4208.642265407413, 4216.219999300078, 4238.554951730086, 4247.68142389322, 3801.4867992820614, 3809.371453710107, 3819.1406933439753, 3835.3671644178958, 3849.9230015400094, 5145.0, 5154.53609175176, 5195.6622819516615, 5248.895022099537, 5283.392409872837, 5470.781168753285, 5486.31421072366, 5495.395506494282, 5500.367457742411, 5512.173174023928, 5104.157813960729, 5104.3619547556555, 5107.642465027412, 5109.131447653907, 5154.304168937146, 4670.346151538787, 4711.528847115261, 4732.881677958009, 4768.380110585671, 4769.904601907942, 5802.448767367094, 5822.039363504974, 5840.912386314209, 5868.794592189253, 5869.765209391662, 5463.863403414946, 5540.445955404427, 5541.418151094077, 5544.112941929272, 5594.580406469449, 5896.056630939201, 5924.348321684525, 5927.051671732502, 5961.52307815365, 5965.164876917148, 5503.257060296809, 5507.586930980273, 5507.779688812403, 5517.36550296721, 5517.558595312285, 5508.752106155152, 5577.5537956962535, 5581.665100094007, 5587.608867379245, 5634.661920284796, 5475.6440831345835, 5478.123500239943, 5478.45215478449, 5502.58730595215, 5527.944720552743, 5331.600129990344, 5360.303160589098, 5413.0, 5418.891622167455, 5444.891102177855, 5141.742912854267, 5329.866753331198, 5366.275552800322, 5367.194920761917, 5383.515483606494, 5508.91736623943, 5512.641678290898, 5515.806946756844, 5520.06158952971, 5551.666899986014, 5374.059539580636, 5397.8110766123, 5402.432744561922, 5410.026195284887, 5413.945860541344], "unit": "score", "name": "dojo.html", "value": 5151.100266421214}, {"lowerIsBetter": false, "replicates": [472.4024109501481, 517.2654830141202, 524.997255242487, 525.3485677759575, 537.1325309624955, 29106.563401548967, 37638.0, 37702.62297377025, 37709.622903770956, 38015.23969520608, 40800.183996320055, 41380.58619413805, 41477.17045659085, 41584.58415415845, 41642.0, 7464.402847772192, 8537.573121343923, 8749.693760718375, 9994.500274986221, 10179.338343007681, 10159.0, 10308.793824123513, 10319.484025798718, 10322.174226061898, 10326.586936522568, 10276.229282803783, 10354.896451035505, 10360.378377297386, 10362.585496580128, 10368.01503857136, 10205.642802501914, 10298.48507574622, 10335.793284134275, 10339.172866170687, 10342.327748696349, 9978.101970822589, 10065.094141527297, 10103.646372377005, 10409.739756506073, 10495.63265285719, 41309.380359294635, 41628.58371416277, 41901.79049104766, 42053.1589368214, 42208.3668744969, 3071.247544351626, 3111.984440077808, 3266.6080070391467, 3353.8658453661824, 3396.813175275359, 29162.556692854883, 29851.0, 29896.252593685116, 30069.849650751607, 30077.849610751808, 3278.7868788528667, 3280.3439312137666, 3359.8320083995704, 3368.5115658229665, 3451.0682115828836, 284248.0, 284830.0, 285442.0, 286077.9999999979, 286336.0, 61799.38200617936, 61906.38093619096, 62221.0, 62242.377576224564, 62288.688556556925, 64772.35227647758, 64804.0, 64819.67590162019, 64869.351306487275, 64885.0, 15499.225038748244, 15517.146556939477, 15608.609784755472, 15654.9217253913, 15665.68668626621, 12195.817062744067, 12240.387980600934, 12283.69290767738, 12288.877111228774, 12299.0, 19217.90391048036, 20134.496637584176, 20301.492462688257, 20343.389698309074, 20361.796382036286, 6827.590344579341, 6920.826979325457, 6922.480813938974, 6971.6862741176765, 6987.301269872972, 851.586980314547, 852.1521086518953, 855.9400841941005, 859.5315553023618, 1005.5022763732, 28979.56530652042, 30007.549886751716, 30046.24884377908, 30528.389432211676, 30704.53943190854, 889.6174644902625, 906.8549032154956, 985.4727720669407, 1029.7734498410339, 1035.6892932120334, 13212.603621891358, 13672.453101876012, 13867.583972480841, 13867.86132138686, 13870.861291387158, 262500.0, 264327.0, 265668.0, 266369.0, 267333.0, 50335.74832125889, 50685.0, 50693.49306506961, 50726.0, 55893.0, 1183.4378520652897, 1242.0, 1257.5409975358928, 1257.6352857671357, 1277.3868543099363, 26003.60994585045, 27644.58533122045, 27781.861090694416, 28907.855460722563, 29493.705062949954, 36639.63360366362, 37139.628603713616, 37190.25619487649, 37210.44184337183, 37307.6269237315, 227516.0, 229601.0, 230177.0, 230359.0, 231076.0, 28134.2966425841, 32145.35709285848, 32331.51502727508, 32558.83720581382, 32602.184945376557, 38339.80830095831, 38946.415803763535, 39476.605233947295, 39641.60358396379, 39708.801455992536, 32891.671083288864, 33166.66833331636, 33594.832025839714, 33800.830995844866, 36239.0, 34872.47691284683, 35556.466652999705, 35744.0, 35758.46362304516, 35934.0, 34971.65028349684, 35602.8219858899, 35755.0, 35789.0, 36113.0, 30827.0, 31793.94766055529, 31867.043988680376, 32035.519467207545, 32056.839715802205, 24383.26850194497, 24450.388740281636, 24518.264452066465, 24859.12993045235, 25125.623115652914], "unit": "score", "name": "ext.html", "value": 18107.28691041447}, {"lowerIsBetter": false, "replicates": [363.79445613228506, 363.95268615080033, 373.27025664825265, 375.33752926085447, 379.9544054713435, 16853.157342132905, 17403.912980435096, 18674.25302987879, 18676.06619669016, 18677.439676809685, 17490.38783642573, 17891.821081789178, 18062.638747225046, 18067.27730890763, 18073.096345182723, 5299.708516031607, 5579.497845193931, 5587.664740115586, 5600.299962504687, 5600.6079574429805, 4119.752814831105, 5488.259085023511, 5885.676287804169, 6136.23297087864, 6142.3550527194675, 6067.696615169246, 6089.269287685462, 6091.208142941434, 6091.512678985692, 6097.908531372033, 5846.561507886904, 6092.964196086632, 6117.969410152965, 6118.235220597403, 6120.112583675386, 3702.38910579754, 5216.921746173811, 5385.030694474993, 5386.515213630752, 5400.513953744182, 19993.700094498596, 20320.28878989243, 20425.69361459579, 20427.5914481711, 20674.483137921674, 1751.3257395902542, 1956.3739603326942, 2132.0, 2254.966175507369, 2384.950621726452, 12108.515659373614, 12165.087618428654, 12290.0, 12430.502779888793, 12600.0, 1657.8590819780334, 1668.2909763350528, 1685.4438035448272, 1697.9490615281438, 1708.1715368046487, 63996.68001660008, 66203.3379666202, 66705.0, 67159.3284067158, 67995.66002169957, 9793.21654267657, 9933.950330248303, 10123.443210623487, 10222.13111885498, 10436.008579184965, 12636.0, 12878.227306361461, 12881.806772898413, 12900.161489503153, 13356.332183390792, 7681.347085497683, 7770.494917830323, 7915.327197188189, 7917.920820791834, 8047.436679432383, 7722.42081843864, 7783.883241751379, 7869.449138560246, 7997.0, 8008.719694810654, 6104.145419641254, 6107.45032947028, 6131.50947924165, 6144.262688477412, 6290.685465726787, 1683.2088918208422, 1733.471291256179, 1734.9392771252947, 1759.876808623384, 1814.6280012597385, 795.550513959611, 863.9913600864037, 884.4074470105045, 914.6707185413246, 929.8140371925642, 16366.590835229215, 16808.243629036722, 17388.391406300718, 17598.296068157386, 17698.203580838635, 922.6816748221853, 929.0, 947.9620815167316, 1015.9542820573092, 1064.5475672839013, 9886.357386769982, 10500.947495262475, 10536.0, 10565.701117526049, 10598.152147828156, 417076.0, 419070.0, 419736.0, 419895.0, 438428.0, 72416.63791681008, 73862.63068684623, 74895.5020899579, 75283.62358188284, 75362.24637753662, 1019.4393083803878, 1048.6801525534786, 1057.814882395593, 1061.639042725477, 1065.4992153687754, 15916.602084947968, 15937.282822272793, 16099.517014489116, 16272.837271627606, 16605.50183494497, 33341.83329083339, 35376.29247414986, 35477.467837982964, 35835.462468063524, 36748.0, 49077.0, 51394.48605513897, 51471.22793158181, 52022.21966670579, 52335.73832130968, 8096.352291816758, 8116.918830811616, 8236.229210719484, 8301.709440169565, 8542.74371768848, 8710.782230444289, 9815.411075335503, 12058.397080146133, 12992.935035324763, 13139.474421023053, 10602.0, 10840.783184336111, 10875.51060202277, 10965.451727413438, 11586.652400428, 10900.509477073392, 10920.2901811382, 11244.325340479598, 11369.715757106138, 11548.249363791327, 10719.89280107189, 10759.838602421127, 10804.459777011276, 10936.125109991022, 11680.591179308683, 8356.206160414751, 8417.873731893904, 8471.364647651328, 8649.61076751535, 8722.0, 10165.949170254102, 11156.665300041012, 11180.720481988015, 11627.709307267385, 11680.415979200836], "unit": "score", "name": "jquery.html", "value": 8685.811446223115}, {"lowerIsBetter": false, "replicates": [1368.7741522648764, 1445.6096853849465, 1454.97817532737, 1620.5219460259223, 1797.05654531371, 6741.494387920907, 7118.928810711898, 7288.271172882709, 7295.4893157479, 7298.81752956175, 7274.781756547299, 7449.068866391701, 7451.776446706594, 7453.55278683278, 7460.0, 1971.5071232191951, 2018.1221168791549, 2209.1826024371007, 2238.1271304191378, 2263.366257447909, 2217.73387193537, 2225.9777402226014, 2230.018791731641, 2231.040652519416, 2231.6094683430415, 2207.415035015722, 2238.5746708125403, 2245.8764767937755, 2266.5693518231565, 2269.3305474884864, 2226.0873042052845, 2232.174095584628, 2245.9887700561558, 2255.3684968208927, 2261.9434514137115, 2226.2875879718335, 2227.3318004598555, 2239.305815197294, 2245.539664368817, 2248.8875556222124, 7512.661930213154, 7584.4690871639, 7592.126905405894, 7612.086549614027, 7687.769366919001, 4693.859184224445, 4826.0830442215865, 4826.34844296019, 4826.686265392738, 4830.589399901012, 2943.5290353543546, 2953.7193966573354, 3079.63044434667, 3086.5215891536845, 3096.9535456968165, 968.4334664221439, 981.40134517944, 982.9162176186459, 995.21875327868, 1028.2082796246923, 10246.026627470454, 10246.743831404274, 10250.641227557, 10266.281360304782, 10268.07587317145, 4221.957780422218, 4285.057287396768, 4393.275109606943, 4411.977940110343, 4414.3157810539415, 8793.692220772242, 8802.339824513187, 8806.823863522823, 8829.072947340564, 8829.514376709214, 4825.252085926687, 4836.903261934742, 4842.927356089662, 4847.636427267969, 4854.393200849894, 3826.215625796761, 4240.088380998101, 4340.674449416307, 4388.100439409914, 4412.6690498212765, 3670.1925576373155, 3746.550413950343, 3746.737728359043, 3765.736398452082, 3816.6374194452037, 1194.1402190422882, 1206.9637910862689, 1210.2798834693344, 1220.3105245536244, 1224.7856625090574, 908.1327332397544, 919.8712180294764, 924.4360939826701, 975.4050029482011, 1256.3153081570565, 7215.530990485601, 7215.747448839265, 7217.386522145676, 7242.348188662941, 7251.601161936144, 503.9769268385184, 506.4378539820796, 516.8630312967067, 518.8184135552602, 519.7011718262014, 5645.463680950304, 5670.773169073191, 5688.203651488795, 5713.885722285614, 5737.139429085671, 8839.425437346552, 9133.086691330947, 9164.358494905426, 9272.721818345326, 9290.1174388433, 8827.382083254111, 8953.955230223808, 9038.09619038091, 9082.86375704365, 9089.363744537952, 7113.786586402416, 7229.7469588564145, 7244.673989670478, 7287.562746235137, 7304.5982470963545, 6886.10480637534, 6912.308769123048, 6974.895376569254, 7014.964925175342, 7015.614141222281, 7923.128455869965, 8101.797455063671, 8145.674173033012, 8317.251447369525, 8324.833503329779, 8070.5964701763505, 8191.631376587949, 8340.124286949784, 8340.457870238415, 8350.164983501601, 6100.664463454553, 6378.52161087911, 6583.44040756541, 6609.4712423007, 6710.530262881552, 6997.160340758938, 7004.369606735215, 7009.2990700929495, 7060.858782824212, 7067.328603782633, 6307.337729538516, 6462.998235273541, 6490.610563366213, 6554.63949482783, 6556.0493728410065, 6099.84750381244, 6159.23009623797, 6214.40963108504, 6307.716152773044, 6375.107484952017, 6482.967585162044, 6498.447631951337, 6536.3136870627895, 6541.967290163519, 6545.836354091186, 6101.115338276014, 6149.938500614937, 6152.538559607958, 6157.4458298753325, 6282.2147231596055, 6304.779332723333, 6309.842253943688, 6333.556651034383, 6354.4598709108395, 6381.7128229228865], "unit": "score", "name": "mootools.html", "value": 4267.503909519325}, {"lowerIsBetter": false, "replicates": [345.3386764346277, 347.17892184982526, 348.2599476113259, 349.25782711737565, 355.03784743345517, 5912.704364781765, 5914.881702365956, 5938.257717785277, 5962.433568810967, 5969.462748352647, 5895.793647222348, 5897.20387747654, 5899.643082091122, 5901.527877769779, 5908.291005079396, 4377.299632058871, 4476.306172543244, 4541.818327266906, 4575.771211439432, 4635.304704294357, 4546.568076032771, 4574.83988060418, 4581.65637577183, 4582.564656357641, 4586.518415566367, 4553.225951588238, 4556.476005259405, 4578.0, 4581.1753884300815, 4582.587567118959, 4293.935590966138, 4435.84474543391, 4488.842890498817, 4497.9100417991785, 4536.614387777043, 3967.206558688274, 3967.940480892789, 3971.0667993021616, 3975.2447035063533, 3976.8608098716404, 5649.6327738696855, 5651.1523271509195, 5652.434756524356, 5656.519195868356, 5657.2928383952, 5267.446918073585, 5271.499207575274, 5273.393559740641, 5278.683279003272, 5293.0, 6283.937160628427, 6287.591306565058, 6292.1820163378925, 6292.528060395489, 6297.716602752887, 4213.0, 4325.8485952991805, 4346.500152482474, 4415.116976604692, 4425.09285596452, 6501.544891857572, 6546.050822630692, 6571.835704107436, 6584.275729669685, 6590.373914478117, 4462.174497717932, 4467.039586488921, 4468.486124095705, 4470.262406702923, 4471.686981911235, 4527.253003254426, 4532.297493888453, 4532.79602417892, 4534.6372290216705, 4538.546145385501, 5256.106461901486, 5258.316418865523, 5260.605454590921, 5261.0793111205385, 5265.368155821326, 6193.907091393633, 6246.906296405557, 6338.207724034496, 6348.730253949137, 6351.9682401588625, 1560.6956643454644, 1566.4908904606048, 1584.0574857959725, 1586.3178833101647, 1588.6584384357188, 958.5494817435933, 1031.7369070886875, 1034.896510348959, 1048.8741351037925, 1065.6217042949797, 5896.233489646319, 5942.554308426799, 5957.553183511254, 5961.0, 5965.522758179335, 6443.5167362448, 6454.806355809239, 6458.0, 6458.6770661466735, 6462.224533055969, 5923.348431672513, 5933.554983376264, 5934.910976335358, 5939.613925094855, 5943.8216853493595, 3441.2257242120822, 3473.4442489201606, 3480.6693364130365, 3482.059843842199, 3486.6687664671817, 6680.131582894192, 6842.5552339098795, 6848.246692863781, 6921.2732663069655, 6968.128983877015, 6674.83312917181, 6705.0, 6720.798376048726, 6725.798226053226, 6732.798016059526, 6930.237673855871, 6947.096877405905, 6947.548409353376, 6952.5480843745, 6955.269696681877, 6492.577982431316, 6529.412352888263, 6534.542582019213, 6536.084948107174, 6541.70562324706, 6273.341299163522, 6448.419642232222, 6487.967560162358, 6489.707963141765, 6490.188726409199, 6931.306869313028, 6952.339527744856, 6971.755988540377, 6981.79054628362, 6990.895136573057, 4437.445319335083, 4507.887302817456, 4508.594226519629, 4509.053098849278, 4517.616002639812, 6585.934140658532, 6591.209054913249, 6593.736250549924, 6597.50518711089, 6599.373059559334, 6261.749530018748, 6369.522285828489, 6371.171747672773, 6381.457576106083, 6382.042693595998, 6299.874002520016, 6372.55392122547, 6379.457746091634, 6383.648899310582, 6388.073729309317, 6244.250689917239, 6264.436200741955, 6269.467095296768, 6272.8431789203805, 6281.0, 6340.0, 6401.327860574573, 6408.134901788386, 6409.262934762562, 6413.8396540085005, 6006.429389208019, 6054.182685337423, 6234.657093859882, 6242.65665388408, 6250.656213908279], "unit": "score", "name": "prototype.html", "value": 4766.844129608118}, {"lowerIsBetter": false, "replicates": [674.5986138247742, 688.0607970120786, 699.1156187422911, 703.4688809948489, 706.4454403293415, 13778.793318100237, 13891.305434728274, 13904.235267060307, 13923.930380348109, 13945.163290202583, 11604.129690273243, 13169.078164528486, 13188.0, 13190.274534900576, 13214.933925330384, 836.7615229659564, 844.6494704697543, 845.8054647431095, 846.5047946951041, 849.5454931611589, 850.6342272822684, 854.3250831842837, 857.5969294431607, 859.7721603775004, 861.9094995025526, 894.6645008121955, 895.5253715530779, 896.6458248991645, 897.2104547997753, 897.2149369301861, 726.96728647211, 876.8071024374627, 876.9649214031431, 877.5305211711767, 877.6006916852848, 642.7172044300493, 644.262319644005, 644.6228956060663, 644.78399736088, 645.0356716708504, 13436.193828370231, 13448.529301474498, 13545.661358466019, 13559.59321220365, 13571.253581053137, 11277.0, 11599.304041757438, 11642.417879106095, 11788.882111178864, 11891.881081189164, 9321.860172097424, 9357.204637605812, 9401.294902882311, 9500.097490738437, 9619.230461563058, 3109.9533506997413, 3143.2770462793455, 3165.2878102427, 3231.8545665445113, 3233.2401885556874, 47639.523604763854, 48234.51765482335, 48347.51652483465, 48568.0, 48675.513244867456, 8761.518116503654, 8887.244584210286, 8944.910550894409, 8953.238974687225, 9273.675421360354, 17609.647807043788, 17612.119394030247, 17638.0, 17801.554961126076, 17826.0, 6637.878591445285, 6863.142107236596, 7048.189458212269, 7071.575705457689, 7243.3340331724, 4009.7393669411395, 4015.0, 4074.083331250445, 4107.301758701028, 4167.687423443193, 3047.7104675055834, 3048.3141293209296, 3057.3121047764075, 3065.5095184770776, 3099.9535006974916, 504.06747517093083, 521.3144714700157, 525.4141632080203, 547.6221407228999, 561.9494245517923, 536.3831593667314, 545.3020134228194, 559.5467671186352, 566.5156291370901, 572.074439079525, 7842.176571459914, 7848.960755196302, 7886.684532618746, 7918.0, 8029.919700803034, 519.5531842615347, 523.2857149990311, 539.7301349325337, 542.0838782457633, 542.5659472422126, 3484.4773284007097, 3666.8816011116865, 3668.2296717689583, 3760.0599850037493, 3802.524684414448, 52411.0, 53528.46471535235, 54201.45798542043, 54301.0, 54344.72827635916, 48028.27957580569, 49191.508084919406, 49918.25122623164, 49957.25064124041, 50263.49736502661, 44368.778156109016, 45129.0, 45443.54556454459, 47460.0, 48265.75867120642, 7012.228654848064, 7042.964785176041, 7044.577325360495, 7164.211936687065, 7207.783766487014, 32907.341853163285, 33618.15954601154, 34495.0, 35109.297814043064, 35328.29343413066, 38365.80817095897, 39376.803115984236, 42575.36136957886, 44311.33532996943, 44526.77736611296, 9921.454320012468, 10019.499025048864, 10138.290319677551, 10154.238432117769, 10162.085412312927, 10723.356598604109, 10895.0, 10925.726856828325, 10998.0, 11380.54477820911, 10181.694549163536, 10292.125169360688, 10442.843357349799, 10506.264561480928, 10870.945645271722, 10435.895641043797, 10576.629817956335, 10581.735456613646, 10854.185936054986, 10899.0, 10024.0, 10050.09549140581, 10070.446125462877, 10213.540390682585, 10335.276530643083, 7913.9604301978125, 7930.31862975843, 8229.094799572162, 8236.50580965144, 8400.537970411686, 7874.291313781787, 8327.669433295785, 8643.092475290005, 8787.868181977403, 8854.0], "unit": "score", "name": "yui.html", "value": 5934.094154676755}], "name": "dromaeo_css", "value": 6787.772194242684}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 110.0, 104.0, 111.0, 110.0, 110.0, 100.0, 110.0, 109.0, 110.0], "unit": "score", "name": "ai-astar", "value": 108.2}, {"lowerIsBetter": true, "replicates": [157.0, 134.0, 154.0, 174.0, 131.0, 157.0, 160.0, 128.0, 174.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 149.6}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 160.0, 160.0, 161.0, 162.0, 161.0, 164.0, 163.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.7}, {"lowerIsBetter": true, "replicates": [76.0, 76.0, 103.0, 101.0, 75.0, 73.0, 75.0, 116.0, 98.0, 74.0], "unit": "score", "name": "audio-fft", "value": 86.7}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 137.0, 93.0, 95.0, 94.0, 147.0, 94.0, 93.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 108.3}, {"lowerIsBetter": true, "replicates": [116.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.6}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 144.0, 144.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.0}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 56.0, 57.0, 57.0, 57.0, 56.0, 64.0, 54.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.7}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 69.0, 68.0, 68.0, 69.0, 69.0, 69.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [81.0, 83.0, 83.0, 91.0, 82.0, 83.0, 81.0, 83.0, 82.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.1}, {"lowerIsBetter": true, "replicates": [124.0, 121.0, 124.0, 115.0, 111.0, 114.0, 114.0, 112.0, 115.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.4}, {"lowerIsBetter": true, "replicates": [160.0, 147.0, 144.0, 146.0, 146.0, 140.0, 149.0, 150.0, 159.0, 149.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.0}, {"lowerIsBetter": true, "replicates": [67.0, 70.0, 71.0, 70.0, 68.0, 69.0, 67.0, 71.0, 68.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.7}], "name": "kraken", "value": 1514.0}]} 05:56:40 INFO - Return code: 0 05:56:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:56:40 INFO - # TBPL SUCCESS # 05:56:40 INFO - Running post-action listener: _resource_record_post_action 05:56:40 INFO - Running post-run listener: _resource_record_post_run 05:56:41 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 8192; Write bytes: 530698240; Read time: 192; Write time: 493724 05:56:41 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 240762880; Read time: 0; Write time: 275492 05:56:41 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 8192; Write bytes: 289787904; Read time: 192; Write time: 218188 05:56:41 INFO - Running post-run listener: _upload_blobber_files 05:56:41 INFO - Blob upload gear active. 05:56:41 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:56:41 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 05:56:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 05:56:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 05:56:42 INFO - (blobuploader) - INFO - Open directory for files ... 05:56:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 05:56:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:56:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:56:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:56:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:56:43 INFO - (blobuploader) - INFO - Done attempting. 05:56:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:56:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:56:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:56:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:56:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:56:43 INFO - (blobuploader) - INFO - Done attempting. 05:56:43 INFO - (blobuploader) - INFO - Iteration through files over. 05:56:43 INFO - Return code: 0 05:56:43 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:56:43 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:56:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c893d390b21df4dcd5d6865bf24773b9e019b150e10554d82d74106a71cb122266dcbcabce252620c1a48aa96375aea1e994b9c5d2e9c0abf03c7ea9ed92bae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3ff077578f97aff7ddab9990ead4661bc6ec2e22b929ac160063b86608353f32b1d00f7c3afd393d1b7a061d8f1c60763b1a8f48f2cdeee9b00b8f83a7f4ac5b"} 05:56:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:56:43 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:56:43 INFO - Contents: 05:56:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c893d390b21df4dcd5d6865bf24773b9e019b150e10554d82d74106a71cb122266dcbcabce252620c1a48aa96375aea1e994b9c5d2e9c0abf03c7ea9ed92bae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3ff077578f97aff7ddab9990ead4661bc6ec2e22b929ac160063b86608353f32b1d00f7c3afd393d1b7a061d8f1c60763b1a8f48f2cdeee9b00b8f83a7f4ac5b"} 05:56:43 INFO - Running post-run listener: copy_logs_to_upload_dir 05:56:43 INFO - Copying logs to upload dir... 05:56:43 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 05:56:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.684399 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-03-07 05:56:42.937465) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-07 05:56:42.940735) ========= 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=eca2ab57546de7b41f256b19000001ef-1457357447.524786-547682945 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c893d390b21df4dcd5d6865bf24773b9e019b150e10554d82d74106a71cb122266dcbcabce252620c1a48aa96375aea1e994b9c5d2e9c0abf03c7ea9ed92bae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3ff077578f97aff7ddab9990ead4661bc6ec2e22b929ac160063b86608353f32b1d00f7c3afd393d1b7a061d8f1c60763b1a8f48f2cdeee9b00b8f83a7f4ac5b"} build_url:https://queue.taskcluster.net/v1/task/GCOOGTTQTRePB11bu1avvg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011416 build_url: 'https://queue.taskcluster.net/v1/task/GCOOGTTQTRePB11bu1avvg/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/Firefox/sha512/3c893d390b21df4dcd5d6865bf24773b9e019b150e10554d82d74106a71cb122266dcbcabce252620c1a48aa96375aea1e994b9c5d2e9c0abf03c7ea9ed92bae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3ff077578f97aff7ddab9990ead4661bc6ec2e22b929ac160063b86608353f32b1d00f7c3afd393d1b7a061d8f1c60763b1a8f48f2cdeee9b00b8f83a7f4ac5b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-07 05:56:42.964946) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 05:56:42.965278) ========= 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=eca2ab57546de7b41f256b19000001ef-1457357447.524786-547682945 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004488 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 05:56:43.049845) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-07 05:56:43.050170) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-07 05:56:43.050531) ========= ========= Total master_lag: 0.27 =========