builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-068 starttime: 1457140155.77 results: success (0) buildid: 20160304143018 builduid: 55cb482af74848c0b15495c8dbfa224e revision: 269d8cec9a9b143ef4947f5cb37c915c5ee607db ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-04 17:09:15.768874) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-04 17:09:15.769433) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-04 17:09:15.769784) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1457140154.704486-282231353 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006352 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-04 17:09:15.793102) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-04 17:09:15.793555) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-04 17:09:15.816244) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 17:09:15.816668) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1457140154.704486-282231353 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014161 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 17:09:15.864521) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-04 17:09:15.864907) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-04 17:09:15.865351) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 17:09:15.865727) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1457140154.704486-282231353 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-04 17:09:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 219M=0s 2016-03-04 17:09:16 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.150218 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 17:09:16.029112) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 17:09:16.029495) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1457140154.704486-282231353 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.128086 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 17:09:16.169928) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 17:09:16.170378) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 269d8cec9a9b143ef4947f5cb37c915c5ee607db --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 269d8cec9a9b143ef4947f5cb37c915c5ee607db --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=97facb8ba2ac28944cc45e6b000001d4-1457140154.704486-282231353 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-04 17:09:16,288 truncating revision to first 12 chars 2016-03-04 17:09:16,288 Setting DEBUG logging. 2016-03-04 17:09:16,288 attempt 1/10 2016-03-04 17:09:16,288 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/269d8cec9a9b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-04 17:09:16,551 unpacking tar archive at: fx-team-269d8cec9a9b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.566288 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 17:09:16.749640) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-04 17:09:16.750002) ========= echo 269d8cec9a9b143ef4947f5cb37c915c5ee607db in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'269d8cec9a9b143ef4947f5cb37c915c5ee607db'] 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=97facb8ba2ac28944cc45e6b000001d4-1457140154.704486-282231353 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 269d8cec9a9b143ef4947f5cb37c915c5ee607db program finished with exit code 0 elapsedTime=0.003331 script_repo_revision: '269d8cec9a9b143ef4947f5cb37c915c5ee607db' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-04 17:09:16.798045) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-04 17:09:16.798368) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-04 17:09:16.808150) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-03-04 17:09:16.808497) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=97facb8ba2ac28944cc45e6b000001d4-1457140154.704486-282231353 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:09:17 INFO - MultiFileLogger online at 20160304 17:09:17 in /builds/slave/test-pgo 17:09:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:09:17 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 17:09:17 INFO - {'append_to_log': False, 17:09:17 INFO - 'base_work_dir': '/builds/slave/test-pgo', 17:09:17 INFO - 'blob_upload_branch': 'Fx-Team', 17:09:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 17:09:17 INFO - 'branch': 'Fx-Team', 17:09:17 INFO - 'buildbot_json_path': 'buildprops.json', 17:09:17 INFO - 'config_files': ('talos/linux_config.py',), 17:09:17 INFO - 'default_actions': ('clobber', 17:09:17 INFO - 'read-buildbot-config', 17:09:17 INFO - 'download-and-extract', 17:09:17 INFO - 'populate-webroot', 17:09:17 INFO - 'create-virtualenv', 17:09:17 INFO - 'install', 17:09:17 INFO - 'run-tests'), 17:09:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:09:17 INFO - 'download_minidump_stackwalk': True, 17:09:17 INFO - 'download_symbols': 'ondemand', 17:09:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:09:17 INFO - 'tooltool.py': '/tools/tooltool.py', 17:09:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:09:17 INFO - '/tools/misc-python/virtualenv.py')}, 17:09:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:09:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:09:17 INFO - 'installer_path': 'installer.exe', 17:09:17 INFO - 'log_level': 'info', 17:09:17 INFO - 'log_name': 'talos', 17:09:17 INFO - 'log_to_console': True, 17:09:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:09:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:09:17 INFO - 'opt_config_files': (), 17:09:17 INFO - 'pip_index': False, 17:09:17 INFO - 'sps_profile': False, 17:09:17 INFO - 'sps_profile_interval': 0, 17:09:17 INFO - 'suite': 'dromaeojs', 17:09:17 INFO - 'system_bits': '32', 17:09:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:09:17 INFO - 'title': 'talos-linux64-ix-068', 17:09:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:09:17 INFO - 'use_talos_json': True, 17:09:17 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 17:09:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:09:17 INFO - 'work_dir': 'build'} 17:09:17 INFO - ##### 17:09:17 INFO - ##### Running clobber step. 17:09:17 INFO - ##### 17:09:17 INFO - Running pre-action listener: _resource_record_pre_action 17:09:17 INFO - Running main action method: clobber 17:09:17 INFO - rmtree: /builds/slave/test-pgo/build 17:09:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 17:09:21 INFO - Running post-action listener: _resource_record_post_action 17:09:21 INFO - ##### 17:09:21 INFO - ##### Running read-buildbot-config step. 17:09:21 INFO - ##### 17:09:21 INFO - Running pre-action listener: _resource_record_pre_action 17:09:21 INFO - Running main action method: read_buildbot_config 17:09:21 INFO - Using buildbot properties: 17:09:21 INFO - { 17:09:21 INFO - "project": "", 17:09:21 INFO - "product": "firefox", 17:09:21 INFO - "script_repo_revision": "production", 17:09:21 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:09:21 INFO - "repository": "", 17:09:21 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 17:09:21 INFO - "buildid": "20160304143018", 17:09:21 INFO - "pgo_build": "True", 17:09:21 INFO - "basedir": "/builds/slave/test-pgo", 17:09:21 INFO - "buildnumber": 694, 17:09:21 INFO - "slavename": "talos-linux64-ix-068", 17:09:21 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:09:21 INFO - "platform": "ubuntu64_hw", 17:09:21 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:09:21 INFO - "branch": "fx-team", 17:09:21 INFO - "repo_path": "integration/fx-team", 17:09:21 INFO - "revision": "269d8cec9a9b143ef4947f5cb37c915c5ee607db", 17:09:21 INFO - "stage_platform": "linux64-pgo", 17:09:21 INFO - "builduid": "55cb482af74848c0b15495c8dbfa224e", 17:09:21 INFO - "slavebuilddir": "test" 17:09:21 INFO - } 17:09:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/G98YxQUIRU-85VqCk2Z4qg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 17:09:21 INFO - Running post-action listener: _resource_record_post_action 17:09:21 INFO - ##### 17:09:21 INFO - ##### Running download-and-extract step. 17:09:21 INFO - ##### 17:09:21 INFO - Running pre-action listener: _resource_record_pre_action 17:09:21 INFO - Running main action method: download_and_extract 17:09:21 INFO - mkdir: /builds/slave/test-pgo/build/tests 17:09: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')]} 17:09:21 INFO - https://queue.taskcluster.net/v1/task/G98YxQUIRU-85VqCk2Z4qg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:09:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G98YxQUIRU-85VqCk2Z4qg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 17:09:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G98YxQUIRU-85VqCk2Z4qg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 17:09:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G98YxQUIRU-85VqCk2Z4qg/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 17:09:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G98YxQUIRU-85VqCk2Z4qg/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 17:09:22 INFO - Downloaded 1448 bytes. 17:09:22 INFO - Reading from file /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 17:09:22 INFO - Using the following test package requirements: 17:09:22 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 17:09:22 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:22 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:09:22 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:22 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:09:22 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:22 INFO - u'jsshell-linux-x86_64.zip'], 17:09:22 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:22 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:09:22 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 17:09:22 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:22 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:09:22 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:22 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:09:22 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:22 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:09:22 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 17:09:22 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:22 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:09:22 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:09:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:22 INFO - https://queue.taskcluster.net/v1/task/G98YxQUIRU-85VqCk2Z4qg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:09:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G98YxQUIRU-85VqCk2Z4qg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 17:09:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G98YxQUIRU-85VqCk2Z4qg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 17:09:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G98YxQUIRU-85VqCk2Z4qg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 17:09:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G98YxQUIRU-85VqCk2Z4qg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:09:25 INFO - Downloaded 23396775 bytes. 17:09:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 17:09:25 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 17:09:27 INFO - Return code: 0 17:09:27 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:09: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')]} 17:09:27 INFO - https://queue.taskcluster.net/v1/task/G98YxQUIRU-85VqCk2Z4qg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:09:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G98YxQUIRU-85VqCk2Z4qg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 17:09:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G98YxQUIRU-85VqCk2Z4qg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 17:09:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G98YxQUIRU-85VqCk2Z4qg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 17:09:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G98YxQUIRU-85VqCk2Z4qg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:09:29 INFO - Downloaded 23396775 bytes. 17:09:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 17:09:29 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 17:09:30 INFO - Return code: 0 17:09: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')]} 17:09:30 INFO - https://queue.taskcluster.net/v1/task/G98YxQUIRU-85VqCk2Z4qg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:09:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G98YxQUIRU-85VqCk2Z4qg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 17:09:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G98YxQUIRU-85VqCk2Z4qg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 17:09:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G98YxQUIRU-85VqCk2Z4qg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 17:09:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G98YxQUIRU-85VqCk2Z4qg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:09:32 INFO - Downloaded 10803659 bytes. 17:09:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 17:09:32 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 17:09:32 INFO - Return code: 0 17:09:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:32 INFO - https://queue.taskcluster.net/v1/task/G98YxQUIRU-85VqCk2Z4qg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:09:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G98YxQUIRU-85VqCk2Z4qg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 17:09:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G98YxQUIRU-85VqCk2Z4qg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 17:09:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G98YxQUIRU-85VqCk2Z4qg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 17:09:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G98YxQUIRU-85VqCk2Z4qg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:09:34 INFO - Downloaded 56125526 bytes. 17:09:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/G98YxQUIRU-85VqCk2Z4qg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 17:09:34 INFO - mkdir: /builds/slave/test-pgo/properties 17:09:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 17:09:34 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 17:09:34 INFO - Contents: 17:09:34 INFO - build_url:https://queue.taskcluster.net/v1/task/G98YxQUIRU-85VqCk2Z4qg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 17:09:35 INFO - Running post-action listener: _resource_record_post_action 17:09:35 INFO - Running post-action listener: set_extra_try_arguments 17:09:35 INFO - ##### 17:09:35 INFO - ##### Running populate-webroot step. 17:09:35 INFO - ##### 17:09:35 INFO - Running pre-action listener: _resource_record_pre_action 17:09:35 INFO - Running main action method: populate_webroot 17:09:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:09:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:09:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:09:35 INFO - '--tppagecycles', 17:09:35 INFO - '7'], 17:09:35 INFO - 'tests': ['tsvgm']}}, 17:09:35 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:09:35 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:09:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:09:35 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 17:09:35 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:09:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:09:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:09:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:35 INFO - 'talos_options': ['--e10s'], 17:09:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:09:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:35 INFO - 'tests': ['damp', 'tps']}, 17:09:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:35 INFO - 'talos_options': ['--e10s'], 17:09:35 INFO - 'tests': ['damp', 'tps']}, 17:09:35 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:09:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:09:35 INFO - 'other': {'tests': ['a11yr', 17:09:35 INFO - 'ts_paint', 17:09:35 INFO - 'tpaint', 17:09:35 INFO - 'sessionrestore', 17:09:35 INFO - 'sessionrestore_no_auto_restore']}, 17:09:35 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:09:35 INFO - 'tests': ['a11yr', 17:09:35 INFO - 'ts_paint', 17:09:35 INFO - 'tpaint', 17:09:35 INFO - 'sessionrestore', 17:09:35 INFO - 'sessionrestore_no_auto_restore']}, 17:09:35 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:09:35 INFO - 'tests': ['a11yr', 17:09:35 INFO - 'ts_paint', 17:09:35 INFO - 'tpaint', 17:09:35 INFO - 'sessionrestore', 17:09:35 INFO - 'sessionrestore_no_auto_restore']}, 17:09:35 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:09:35 INFO - 'tests': ['a11yr', 17:09:35 INFO - 'ts_paint', 17:09:35 INFO - 'tpaint', 17:09:35 INFO - 'sessionrestore', 17:09:35 INFO - 'sessionrestore_no_auto_restore']}, 17:09:35 INFO - 'other_l64': {'tests': ['a11yr', 17:09:35 INFO - 'ts_paint', 17:09:35 INFO - 'tpaint', 17:09:35 INFO - 'sessionrestore', 17:09:35 INFO - 'sessionrestore_no_auto_restore']}, 17:09:35 INFO - 'other_nol64': {'tests': ['a11yr', 17:09:35 INFO - 'ts_paint', 17:09:35 INFO - 'tpaint', 17:09:35 INFO - 'sessionrestore', 17:09:35 INFO - 'sessionrestore_no_auto_restore']}, 17:09:35 INFO - 'svgr': {'tests': ['tsvgx', 17:09:35 INFO - 'tsvgr_opacity', 17:09:35 INFO - 'tart', 17:09:35 INFO - 'tscrollx', 17:09:35 INFO - 'cart']}, 17:09:35 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:09:35 INFO - 'tests': ['tsvgx', 17:09:35 INFO - 'tsvgr_opacity', 17:09:35 INFO - 'tart', 17:09:35 INFO - 'tscrollx', 17:09:35 INFO - 'cart']}, 17:09:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:35 INFO - 'tests': ['tp5o']}, 17:09:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:35 INFO - 'talos_options': ['--e10s'], 17:09:35 INFO - 'tests': ['tp5o']}, 17:09:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:35 INFO - 'talos_options': ['--xperf_path', 17:09:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:09:35 INFO - 'tests': ['tp5n']}, 17:09:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:35 INFO - 'talos_options': ['--e10s', 17:09:35 INFO - '--xperf_path', 17:09:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:09:35 INFO - 'tests': ['tp5n']}}, 17:09:35 INFO - 'talos.zip': {'path': '', 17:09:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:09:35 INFO - Running post-action listener: _resource_record_post_action 17:09:35 INFO - ##### 17:09:35 INFO - ##### Running create-virtualenv step. 17:09:35 INFO - ##### 17:09:35 INFO - Running pre-action listener: _resource_record_pre_action 17:09:35 INFO - Running main action method: create_virtualenv 17:09:35 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 17:09:35 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 17:09:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 17:09:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:09:35 INFO - Using real prefix '/usr' 17:09:35 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 17:09:35 INFO - Installing distribute.............................................................................................................................................................................................done. 17:09:37 INFO - Installing pip.................done. 17:09:37 INFO - Return code: 0 17:09:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 17:09:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:37 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 0x7fae23533f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24cd6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255c920>, '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 0x255d820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255dcb0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1457140154.704486-282231353', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:09:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 17:09:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:09:37 INFO - Using env: {'DISPLAY': ':0', 17:09:37 INFO - 'HOME': '/home/cltbld', 17:09:37 INFO - 'LANG': 'en_US.UTF-8', 17:09:37 INFO - 'LANGUAGE': 'en_US:en', 17:09:37 INFO - 'LOGNAME': 'cltbld', 17:09:37 INFO - 'MAIL': '/var/mail/cltbld', 17:09:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:37 INFO - 'MOZ_NO_REMOTE': '1', 17:09:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:37 INFO - 'NO_EM_RESTART': '1', 17:09:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:09:37 INFO - 'PWD': '/builds/slave/test-pgo', 17:09:37 INFO - 'SHELL': '/bin/bash', 17:09:37 INFO - 'SHLVL': '1', 17:09:37 INFO - 'TERM': 'linux', 17:09:37 INFO - 'TMOUT': '86400', 17:09:37 INFO - 'USER': 'cltbld', 17:09:37 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1457140154.704486-282231353', 17:09:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:37 INFO - '_': '/tools/buildbot/bin/python'} 17:09:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:37 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:09:37 INFO - Cleaning up... 17:09:37 INFO - Return code: 0 17:09:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 17:09:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:37 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 0x7fae23533f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24cd6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255c920>, '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 0x255d820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255dcb0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1457140154.704486-282231353', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:09:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 17:09:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 17:09:37 INFO - Using env: {'DISPLAY': ':0', 17:09:37 INFO - 'HOME': '/home/cltbld', 17:09:37 INFO - 'LANG': 'en_US.UTF-8', 17:09:37 INFO - 'LANGUAGE': 'en_US:en', 17:09:37 INFO - 'LOGNAME': 'cltbld', 17:09:37 INFO - 'MAIL': '/var/mail/cltbld', 17:09:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:37 INFO - 'MOZ_NO_REMOTE': '1', 17:09:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:37 INFO - 'NO_EM_RESTART': '1', 17:09:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:09:37 INFO - 'PWD': '/builds/slave/test-pgo', 17:09:37 INFO - 'SHELL': '/bin/bash', 17:09:37 INFO - 'SHLVL': '1', 17:09:37 INFO - 'TERM': 'linux', 17:09:37 INFO - 'TMOUT': '86400', 17:09:37 INFO - 'USER': 'cltbld', 17:09:37 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1457140154.704486-282231353', 17:09:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:37 INFO - '_': '/tools/buildbot/bin/python'} 17:09:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:38 INFO - Downloading/unpacking psutil>=0.7.1 17:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 17:09:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:09:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:09:40 INFO - Installing collected packages: psutil 17:09:40 INFO - Running setup.py install for psutil 17:09:40 INFO - building 'psutil._psutil_linux' extension 17:09:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 17:09:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 17:09:40 INFO - building 'psutil._psutil_posix' extension 17:09:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 17:09:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 17:09:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:09:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:09:40 INFO - Successfully installed psutil 17:09:40 INFO - Cleaning up... 17:09:40 INFO - Return code: 0 17:09:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 17:09:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:40 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fae23533f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24cd6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255c920>, '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 0x255d820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255dcb0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1457140154.704486-282231353', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:09:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 17:09:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 17:09:40 INFO - Using env: {'DISPLAY': ':0', 17:09:40 INFO - 'HOME': '/home/cltbld', 17:09:40 INFO - 'LANG': 'en_US.UTF-8', 17:09:40 INFO - 'LANGUAGE': 'en_US:en', 17:09:40 INFO - 'LOGNAME': 'cltbld', 17:09:40 INFO - 'MAIL': '/var/mail/cltbld', 17:09:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:40 INFO - 'MOZ_NO_REMOTE': '1', 17:09:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:40 INFO - 'NO_EM_RESTART': '1', 17:09:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:09:40 INFO - 'PWD': '/builds/slave/test-pgo', 17:09:40 INFO - 'SHELL': '/bin/bash', 17:09:40 INFO - 'SHLVL': '1', 17:09:40 INFO - 'TERM': 'linux', 17:09:40 INFO - 'TMOUT': '86400', 17:09:40 INFO - 'USER': 'cltbld', 17:09:40 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1457140154.704486-282231353', 17:09:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:40 INFO - '_': '/tools/buildbot/bin/python'} 17:09:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:09: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 17:09: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 17:09: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 17:09: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 17:09: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 17:09: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 17:09:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:09:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:09:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:09:42 INFO - Installing collected packages: mozsystemmonitor 17:09:42 INFO - Running setup.py install for mozsystemmonitor 17:09:42 INFO - Successfully installed mozsystemmonitor 17:09:42 INFO - Cleaning up... 17:09:42 INFO - Return code: 0 17:09:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 17:09: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')]} 17:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09: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')]} 17:09:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:42 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fae23533f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24cd6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255c920>, '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 0x255d820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255dcb0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1457140154.704486-282231353', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:09:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 17:09:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:09:42 INFO - Using env: {'DISPLAY': ':0', 17:09:42 INFO - 'HOME': '/home/cltbld', 17:09:42 INFO - 'LANG': 'en_US.UTF-8', 17:09:42 INFO - 'LANGUAGE': 'en_US:en', 17:09:42 INFO - 'LOGNAME': 'cltbld', 17:09:42 INFO - 'MAIL': '/var/mail/cltbld', 17:09:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:42 INFO - 'MOZ_NO_REMOTE': '1', 17:09:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:42 INFO - 'NO_EM_RESTART': '1', 17:09:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:09:42 INFO - 'PWD': '/builds/slave/test-pgo', 17:09:42 INFO - 'SHELL': '/bin/bash', 17:09:42 INFO - 'SHLVL': '1', 17:09:42 INFO - 'TERM': 'linux', 17:09:42 INFO - 'TMOUT': '86400', 17:09:42 INFO - 'USER': 'cltbld', 17:09:42 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1457140154.704486-282231353', 17:09:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:42 INFO - '_': '/tools/buildbot/bin/python'} 17:09:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:43 INFO - Downloading/unpacking blobuploader==1.2.4 17:09: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 17:09: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 17:09: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 17:09: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 17:09: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 17:09: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 17:09:44 INFO - Downloading blobuploader-1.2.4.tar.gz 17:09:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:09:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:09:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 17:09:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:09: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 17:09: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 17:09: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 17:09: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 17:09: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 17:09: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 17:09:45 INFO - Downloading docopt-0.6.1.tar.gz 17:09:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 17:09:45 INFO - Installing collected packages: blobuploader, requests, docopt 17:09:45 INFO - Running setup.py install for blobuploader 17:09:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:09:45 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 17:09:45 INFO - Running setup.py install for requests 17:09:46 INFO - Running setup.py install for docopt 17:09:46 INFO - Successfully installed blobuploader requests docopt 17:09:46 INFO - Cleaning up... 17:09:46 INFO - Return code: 0 17:09:46 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:09:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:46 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 0x7fae23533f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24cd6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255c920>, '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 0x255d820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255dcb0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1457140154.704486-282231353', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:09:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 17:09:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:09:46 INFO - Using env: {'DISPLAY': ':0', 17:09:46 INFO - 'HOME': '/home/cltbld', 17:09:46 INFO - 'LANG': 'en_US.UTF-8', 17:09:46 INFO - 'LANGUAGE': 'en_US:en', 17:09:46 INFO - 'LOGNAME': 'cltbld', 17:09:46 INFO - 'MAIL': '/var/mail/cltbld', 17:09:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:46 INFO - 'MOZ_NO_REMOTE': '1', 17:09:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:46 INFO - 'NO_EM_RESTART': '1', 17:09:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:09:46 INFO - 'PWD': '/builds/slave/test-pgo', 17:09:46 INFO - 'SHELL': '/bin/bash', 17:09:46 INFO - 'SHLVL': '1', 17:09:46 INFO - 'TERM': 'linux', 17:09:46 INFO - 'TMOUT': '86400', 17:09:46 INFO - 'USER': 'cltbld', 17:09:46 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1457140154.704486-282231353', 17:09:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:46 INFO - '_': '/tools/buildbot/bin/python'} 17:09:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:09:46 INFO - Running setup.py (path:/tmp/pip-MITUfH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:09:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:09:46 INFO - Running setup.py (path:/tmp/pip-kv9U6x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:09:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:09:46 INFO - Running setup.py (path:/tmp/pip-MgFvCr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:09:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:09:46 INFO - Running setup.py (path:/tmp/pip-zG_0kT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:09:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:09:46 INFO - Running setup.py (path:/tmp/pip-06Op9w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:09:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:09:46 INFO - Running setup.py (path:/tmp/pip-0SRH4E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:09:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:09:46 INFO - Running setup.py (path:/tmp/pip-TQRI4R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:09:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:09:46 INFO - Running setup.py (path:/tmp/pip-1lKirN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:09:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:09:47 INFO - Running setup.py (path:/tmp/pip-I7G354-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:09:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:09:47 INFO - Running setup.py (path:/tmp/pip-0QFUCz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:09:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:09:47 INFO - Running setup.py (path:/tmp/pip-KYjbZF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:09:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:09:47 INFO - Running setup.py (path:/tmp/pip-SkGtH8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:09:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:09:47 INFO - Running setup.py (path:/tmp/pip-YZFN_S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:09:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:09:47 INFO - Running setup.py (path:/tmp/pip-3gpbX4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:09:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:09:47 INFO - Running setup.py (path:/tmp/pip-2bqjUD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:09:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:09:47 INFO - Running setup.py (path:/tmp/pip-wrU3BB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:09:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:09:47 INFO - Running setup.py (path:/tmp/pip-uMhJ1v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:09:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:09:47 INFO - Running setup.py install for manifestparser 17:09:47 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 17:09:47 INFO - Running setup.py install for mozcrash 17:09:47 INFO - Running setup.py install for mozdebug 17:09:47 INFO - Running setup.py install for mozdevice 17:09:48 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 17:09:48 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 17:09:48 INFO - Running setup.py install for mozfile 17:09:48 INFO - Running setup.py install for mozhttpd 17:09:48 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 17:09:48 INFO - Running setup.py install for mozinfo 17:09:48 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 17:09:48 INFO - Running setup.py install for mozInstall 17:09:48 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 17:09:48 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 17:09:48 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 17:09:48 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 17:09:48 INFO - Running setup.py install for mozleak 17:09:48 INFO - Running setup.py install for mozlog 17:09:48 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 17:09:48 INFO - Running setup.py install for moznetwork 17:09:48 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 17:09:48 INFO - Running setup.py install for mozprocess 17:09:48 INFO - Running setup.py install for mozprofile 17:09:49 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 17:09:49 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 17:09:49 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 17:09:49 INFO - Running setup.py install for mozrunner 17:09:49 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 17:09:49 INFO - Running setup.py install for mozscreenshot 17:09:49 INFO - Running setup.py install for moztest 17:09:49 INFO - Running setup.py install for mozversion 17:09:49 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 17:09:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:09:49 INFO - Cleaning up... 17:09:49 INFO - Return code: 0 17:09:49 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:09:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:49 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 0x7fae23533f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24cd6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255c920>, '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 0x255d820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255dcb0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1457140154.704486-282231353', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:09:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 17:09:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:09:49 INFO - Using env: {'DISPLAY': ':0', 17:09:49 INFO - 'HOME': '/home/cltbld', 17:09:49 INFO - 'LANG': 'en_US.UTF-8', 17:09:49 INFO - 'LANGUAGE': 'en_US:en', 17:09:49 INFO - 'LOGNAME': 'cltbld', 17:09:49 INFO - 'MAIL': '/var/mail/cltbld', 17:09:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:49 INFO - 'MOZ_NO_REMOTE': '1', 17:09:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:49 INFO - 'NO_EM_RESTART': '1', 17:09:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:09:49 INFO - 'PWD': '/builds/slave/test-pgo', 17:09:49 INFO - 'SHELL': '/bin/bash', 17:09:49 INFO - 'SHLVL': '1', 17:09:49 INFO - 'TERM': 'linux', 17:09:49 INFO - 'TMOUT': '86400', 17:09:49 INFO - 'USER': 'cltbld', 17:09:49 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1457140154.704486-282231353', 17:09:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:49 INFO - '_': '/tools/buildbot/bin/python'} 17:09:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:09:49 INFO - Running setup.py (path:/tmp/pip-A59Pxc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:09:49 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 17:09:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:09:49 INFO - Running setup.py (path:/tmp/pip-okjdAv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:09:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 17:09:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:09:49 INFO - Running setup.py (path:/tmp/pip-EhZ82c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:09:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 17:09:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:09:49 INFO - Running setup.py (path:/tmp/pip-6pZrnI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:09:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 17:09:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:09:49 INFO - Running setup.py (path:/tmp/pip-528eXg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 17:09:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:09:50 INFO - Running setup.py (path:/tmp/pip-AoI8BE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 17:09:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:09:50 INFO - Running setup.py (path:/tmp/pip-amq0ZH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 17:09:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:09:50 INFO - Running setup.py (path:/tmp/pip-XrJH49-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 17:09:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:09:50 INFO - Running setup.py (path:/tmp/pip-MGqe4t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 17:09:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:09:50 INFO - Running setup.py (path:/tmp/pip-VNJo7q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 17:09:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:09:50 INFO - Running setup.py (path:/tmp/pip-jPMeA2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 17:09:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:09:50 INFO - Running setup.py (path:/tmp/pip-XwuU6k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 17:09:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:09:50 INFO - Running setup.py (path:/tmp/pip-cMf4ZW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 17:09:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:09:50 INFO - Running setup.py (path:/tmp/pip-BQ4vr3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 17:09:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:09:50 INFO - Running setup.py (path:/tmp/pip-D85LR8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 17:09:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:09:50 INFO - Running setup.py (path:/tmp/pip-IUyU3_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 17:09:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:09:50 INFO - Running setup.py (path:/tmp/pip-9n5eFV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 17:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 17:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 17:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 17:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 17:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 17:09:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 17:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:52 INFO - Downloading blessings-1.6.tar.gz 17:09:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 17:09:52 INFO - Installing collected packages: blessings 17:09:52 INFO - Running setup.py install for blessings 17:09:52 INFO - Successfully installed blessings 17:09:52 INFO - Cleaning up... 17:09:53 INFO - Return code: 0 17:09:53 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 17:09:53 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:09:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:09:53 INFO - Reading from file tmpfile_stdout 17:09:53 INFO - Current package versions: 17:09:53 INFO - argparse == 1.2.1 17:09:53 INFO - blessings == 1.6 17:09:53 INFO - blobuploader == 1.2.4 17:09:53 INFO - docopt == 0.6.1 17:09:53 INFO - manifestparser == 1.1 17:09:53 INFO - mozInstall == 1.12 17:09:53 INFO - mozcrash == 0.16 17:09:53 INFO - mozdebug == 0.1 17:09:53 INFO - mozdevice == 0.48 17:09:53 INFO - mozfile == 1.2 17:09:53 INFO - mozhttpd == 0.7 17:09:53 INFO - mozinfo == 0.9 17:09:53 INFO - mozleak == 0.1 17:09:53 INFO - mozlog == 3.1 17:09:53 INFO - moznetwork == 0.27 17:09:53 INFO - mozprocess == 0.22 17:09:53 INFO - mozprofile == 0.28 17:09:53 INFO - mozrunner == 6.11 17:09:53 INFO - mozscreenshot == 0.1 17:09:53 INFO - mozsystemmonitor == 0.0 17:09:53 INFO - moztest == 0.7 17:09:53 INFO - mozversion == 1.4 17:09:53 INFO - psutil == 3.1.1 17:09:53 INFO - requests == 1.2.3 17:09:53 INFO - wsgiref == 0.1.2 17:09:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:09:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:53 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 0x7fae23533f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24cd6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255c920>, '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 0x255d820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255dcb0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1457140154.704486-282231353', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:09:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 17:09:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:09:53 INFO - Using env: {'DISPLAY': ':0', 17:09:53 INFO - 'HOME': '/home/cltbld', 17:09:53 INFO - 'LANG': 'en_US.UTF-8', 17:09:53 INFO - 'LANGUAGE': 'en_US:en', 17:09:53 INFO - 'LOGNAME': 'cltbld', 17:09:53 INFO - 'MAIL': '/var/mail/cltbld', 17:09:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:53 INFO - 'MOZ_NO_REMOTE': '1', 17:09:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:53 INFO - 'NO_EM_RESTART': '1', 17:09:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:09:53 INFO - 'PWD': '/builds/slave/test-pgo', 17:09:53 INFO - 'SHELL': '/bin/bash', 17:09:53 INFO - 'SHLVL': '1', 17:09:53 INFO - 'TERM': 'linux', 17:09:53 INFO - 'TMOUT': '86400', 17:09:53 INFO - 'USER': 'cltbld', 17:09:53 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1457140154.704486-282231353', 17:09:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:53 INFO - '_': '/tools/buildbot/bin/python'} 17:09:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 17:09:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 17:09:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 17:09:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 17:09:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 17:09:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 17:09:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 17:09:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 17:09:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 17:09:53 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 17:09:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 17:09:53 INFO - Cleaning up... 17:09:53 INFO - Return code: 0 17:09:53 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 17:09:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:53 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 0x7fae23533f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24cd6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255c920>, '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 0x255d820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255dcb0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1457140154.704486-282231353', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:09:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 17:09:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:09:53 INFO - Using env: {'DISPLAY': ':0', 17:09:53 INFO - 'HOME': '/home/cltbld', 17:09:53 INFO - 'LANG': 'en_US.UTF-8', 17:09:53 INFO - 'LANGUAGE': 'en_US:en', 17:09:53 INFO - 'LOGNAME': 'cltbld', 17:09:53 INFO - 'MAIL': '/var/mail/cltbld', 17:09:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:53 INFO - 'MOZ_NO_REMOTE': '1', 17:09:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:53 INFO - 'NO_EM_RESTART': '1', 17:09:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:09:53 INFO - 'PWD': '/builds/slave/test-pgo', 17:09:53 INFO - 'SHELL': '/bin/bash', 17:09:53 INFO - 'SHLVL': '1', 17:09:53 INFO - 'TERM': 'linux', 17:09:53 INFO - 'TMOUT': '86400', 17:09:53 INFO - 'USER': 'cltbld', 17:09:53 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1457140154.704486-282231353', 17:09:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:53 INFO - '_': '/tools/buildbot/bin/python'} 17:09:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:53 INFO - Downloading/unpacking jsonschema 17:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:09:55 INFO - Downloading/unpacking functools32 (from jsonschema) 17:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:55 INFO - Downloading functools32-3.2.3-2.tar.gz 17:09:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 17:09:55 INFO - warning: no files found matching '*.txt' 17:09:55 INFO - no previously-included directories found matching 'build' 17:09:55 INFO - no previously-included directories found matching 'dist' 17:09:55 INFO - no previously-included directories found matching '.git*' 17:09:55 INFO - Installing collected packages: jsonschema, functools32 17:09:55 INFO - Running setup.py install for functools32 17:09:55 INFO - warning: no files found matching '*.txt' 17:09:55 INFO - no previously-included directories found matching 'build' 17:09:55 INFO - no previously-included directories found matching 'dist' 17:09:55 INFO - no previously-included directories found matching '.git*' 17:09:55 INFO - Successfully installed jsonschema functools32 17:09:55 INFO - Cleaning up... 17:09:55 INFO - Return code: 0 17:09:55 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 17:09:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:55 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 0x7fae23533f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24cd6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255c920>, '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 0x255d820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255dcb0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1457140154.704486-282231353', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:09:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 17:09:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:09:55 INFO - Using env: {'DISPLAY': ':0', 17:09:55 INFO - 'HOME': '/home/cltbld', 17:09:55 INFO - 'LANG': 'en_US.UTF-8', 17:09:55 INFO - 'LANGUAGE': 'en_US:en', 17:09:55 INFO - 'LOGNAME': 'cltbld', 17:09:55 INFO - 'MAIL': '/var/mail/cltbld', 17:09:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:55 INFO - 'MOZ_NO_REMOTE': '1', 17:09:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:55 INFO - 'NO_EM_RESTART': '1', 17:09:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:09:55 INFO - 'PWD': '/builds/slave/test-pgo', 17:09:55 INFO - 'SHELL': '/bin/bash', 17:09:55 INFO - 'SHLVL': '1', 17:09:55 INFO - 'TERM': 'linux', 17:09:55 INFO - 'TMOUT': '86400', 17:09:55 INFO - 'USER': 'cltbld', 17:09:55 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1457140154.704486-282231353', 17:09:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:55 INFO - '_': '/tools/buildbot/bin/python'} 17:09:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:56 INFO - Downloading/unpacking flake8 17:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:09:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:09:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 17:09:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:09:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:09:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:09:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:09:58 INFO - no previously-included directories found matching 'docs/_build' 17:09:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:09:58 INFO - Running setup.py install for pep8 17:09:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:09:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:09:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:09:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:09:58 INFO - no previously-included directories found matching 'docs/_build' 17:09:58 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 17:09:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:09:58 INFO - Cleaning up... 17:09:58 INFO - Return code: 0 17:09:58 INFO - Running post-action listener: _resource_record_post_action 17:09:58 INFO - Running post-action listener: _start_resource_monitoring 17:09:58 INFO - Starting resource monitoring. 17:09:58 INFO - ##### 17:09:58 INFO - ##### Running install step. 17:09:58 INFO - ##### 17:09:58 INFO - Running pre-action listener: _resource_record_pre_action 17:09:58 INFO - Running main action method: install 17:09:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:09:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:09:59 INFO - Reading from file tmpfile_stdout 17:09:59 INFO - Detecting whether we're running mozinstall >=1.0... 17:09:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 17:09:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 17:09:59 INFO - Reading from file tmpfile_stdout 17:09:59 INFO - Output received: 17:09:59 INFO - Usage: mozinstall [options] installer 17:09:59 INFO - Options: 17:09:59 INFO - -h, --help show this help message and exit 17:09:59 INFO - -d DEST, --destination=DEST 17:09:59 INFO - Directory to install application into. [default: 17:09:59 INFO - "/builds/slave/test-pgo"] 17:09:59 INFO - --app=APP Application being installed. [default: firefox] 17:09:59 INFO - mkdir: /builds/slave/test-pgo/build/application 17:09:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 17:09:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 17:10:15 INFO - Reading from file tmpfile_stdout 17:10:15 INFO - Output received: 17:10:15 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 17:10:15 INFO - Running post-action listener: _resource_record_post_action 17:10:15 INFO - ##### 17:10:15 INFO - ##### Running run-tests step. 17:10:15 INFO - ##### 17:10:15 INFO - Running pre-action listener: _resource_record_pre_action 17:10:15 INFO - Running main action method: run_tests 17:10:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 17:10:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 17:10:15 INFO - Python 2.7.3 17:10:15 INFO - Return code: 0 17:10:15 INFO - grabbing minidump binary from tooltool 17:10:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:15 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 0x255c920>, '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 0x255d820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255dcb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 17:10:15 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 17:10:15 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 17:10:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:10:15 INFO - Return code: 0 17:10:15 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 17:10:15 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 17:10:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 17:10:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 17:10:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 17:10:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 17:10:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 17:10:16 INFO - Return code: 0 17:10:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/G98YxQUIRU-85VqCk2Z4qg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 17:10:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/G98YxQUIRU-85VqCk2Z4qg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 17:10:16 INFO - Using env: {'DISPLAY': ':0', 17:10:16 INFO - 'HOME': '/home/cltbld', 17:10:16 INFO - 'LANG': 'en_US.UTF-8', 17:10:16 INFO - 'LANGUAGE': 'en_US:en', 17:10:16 INFO - 'LOGNAME': 'cltbld', 17:10:16 INFO - 'MAIL': '/var/mail/cltbld', 17:10:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:10:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 17:10:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:16 INFO - 'MOZ_NO_REMOTE': '1', 17:10:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:10:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:16 INFO - 'NO_EM_RESTART': '1', 17:10:16 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:10:16 INFO - 'PWD': '/builds/slave/test-pgo', 17:10:16 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 17:10:16 INFO - 'SHELL': '/bin/bash', 17:10:16 INFO - 'SHLVL': '1', 17:10:16 INFO - 'TERM': 'linux', 17:10:16 INFO - 'TMOUT': '86400', 17:10:16 INFO - 'USER': 'cltbld', 17:10:16 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1457140154.704486-282231353', 17:10:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:16 INFO - '_': '/tools/buildbot/bin/python'} 17:10:16 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/G98YxQUIRU-85VqCk2Z4qg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 17:10:16 INFO - mozversion application_buildid: 20160304143018 17:10:16 INFO - mozversion application_changeset: 269d8cec9a9b143ef4947f5cb37c915c5ee607db 17:10:16 INFO - mozversion application_display_name: Nightly 17:10:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:10:16 INFO - mozversion application_name: Firefox 17:10:16 INFO - mozversion application_remotingname: firefox 17:10:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:10:16 INFO - mozversion application_vendor: Mozilla 17:10:16 INFO - mozversion application_version: 47.0a1 17:10:16 INFO - mozversion platform_buildid: 20160304143018 17:10:16 INFO - mozversion platform_changeset: 269d8cec9a9b143ef4947f5cb37c915c5ee607db 17:10:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:10:16 INFO - mozversion platform_version: 47.0a1 17:10:16 INFO - using testdate: 1457140216 17:10:16 INFO - actual date: 1457140216 17:10:16 INFO - starting webserver on 'localhost:39074' 17:10:16 INFO - SUITE-START | Running 2 tests 17:10:16 INFO - TEST-START | dromaeo_css 17:10:16 INFO - operating with platform_type : linux_ 17:10:16 INFO - Initialising browser for dromaeo_css test... 17:10:16 INFO - TEST-INFO | started process 9023 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpRvzdTp/profile http://localhost:39074/getInfo.html) 17:10:20 INFO - PROCESS | 9023 | __metrics Screen width/height:1600/1200 17:10:20 INFO - PROCESS | 9023 | colorDepth:24 17:10:20 INFO - PROCESS | 9023 | Browser inner width/height: 1024/697 17:10:20 INFO - PROCESS | 9023 | __metrics 17:10:21 INFO - PROCESS | 9023 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:10:22 INFO - TEST-INFO | 9023: exit 0 17:10:22 INFO - Browser initialized. 17:10:22 INFO - Running cycle 1/1 for dromaeo_css test... 17:10:22 INFO - TEST-INFO | started process 9120 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpRvzdTp/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:10:34 INFO - PROCESS | 9120 | RSS: Main: 153567232 17:10:34 INFO - PROCESS | 9120 | 17:11:26 INFO - PROCESS | 9120 | 1457140286101 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 17:13:33 INFO - PROCESS | 9120 | Cycle 1(1): loaded http://localhost:39074/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39074/tests/dromaeo/cssquery-ext.html) 17:13:34 INFO - PROCESS | 9120 | RSS: Main: 255868928 17:13:34 INFO - PROCESS | 9120 | 17:16:37 INFO - PROCESS | 9120 | Cycle 1(1): loaded http://localhost:39074/tests/dromaeo/cssquery-ext.html (next: http://localhost:39074/tests/dromaeo/cssquery-jquery.html) 17:16:37 INFO - PROCESS | 9120 | RSS: Main: 242753536 17:16:37 INFO - PROCESS | 9120 | 17:19:39 INFO - PROCESS | 9120 | Cycle 1(1): loaded http://localhost:39074/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39074/tests/dromaeo/cssquery-mootools.html) 17:19:40 INFO - PROCESS | 9120 | RSS: Main: 247418880 17:19:40 INFO - PROCESS | 9120 | 17:22:42 INFO - PROCESS | 9120 | Cycle 1(1): loaded http://localhost:39074/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39074/tests/dromaeo/cssquery-prototype.html) 17:22:42 INFO - PROCESS | 9120 | RSS: Main: 214134784 17:22:42 INFO - PROCESS | 9120 | 17:25:45 INFO - PROCESS | 9120 | Cycle 1(1): loaded http://localhost:39074/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39074/tests/dromaeo/cssquery-yui.html) 17:25:46 INFO - PROCESS | 9120 | RSS: Main: 211841024 17:25:46 INFO - PROCESS | 9120 | 17:28:48 INFO - PROCESS | 9120 | Cycle 1(1): loaded http://localhost:39074/tests/dromaeo/cssquery-yui.html (next: http://localhost:39074/tests/dromaeo/cssquery-dojo.html) 17:28:49 INFO - PROCESS | 9120 | RSS: Main: 251965440 17:28:49 INFO - PROCESS | 9120 | 17:28:49 INFO - PROCESS | 9120 | __start_tp_report 17:28:49 INFO - PROCESS | 9120 | _x_x_mozilla_page_load 17:28:49 INFO - PROCESS | 9120 | _x_x_mozilla_page_load_details 17:28:49 INFO - PROCESS | 9120 | |i|pagename|runs| 17:28:49 INFO - PROCESS | 9120 | |0;dojo.html;3055.893043743469;3116.8285744284053;3153.668864769199;3165.161232273448;3175.571297874787;5029.195328747401;5083.161278389061;5113.872153196172;5138.537531622153;5152.819651312205;5150.510701483362;5194.37667479902;5198.428172900978;5207.062728708831;5230.476952304768;4654.441467023962;4658.4642766082;4708.128996135709;4717.457492388367;4756.690815097025;4661.533846615345;4673.602743766767;4693.084848454553;4716.575508204261;4778.689385189969;4590.609798167176;4637.304404339342;4640.303954406849;4642.512536183686;4680.602148817355;4695.67130300879;4748.264019077049;4748.762561871928;4752.928706069411;4789.856304310876;4464.955350446487;4675.228587283094;4726.598239149676;4727.739974301412;4755.762211889391;5011.574016208627;5060.569851562622;5067.163917953533;5092.10888094582;5109.642325037212;5467.972660136714;5472.179173124024;5474;5478.91781623276;5484.396716361197;5515.503604675599;5521.033819081685;5569.888602227933;5572.749226284827;5583.776648934037;5227.320448341691;5240.161574148118;5244.60665450089;5270.367555893241;5290.259363689087;5711.485966263056;5717;5717.714114294268;5719;5738.942610573841;5384.434634363335;5465.152901300305;5504.2294078829;5517.69652669107;5520.558355331564;5557.110862262019;5560.749766260528;5563.916541251884;5569.554435645138;5580.497755202051;5509.752061157257;5524.226608274845;5527.917081243784;5527.944720552743;5533.723313834373;5341.545968592635;5399.352077750695;5433.891322173535;5439.4288599696465;5561.499465048165;4192.24539582878;4196.979015104966;4209.116085621992;4232.957670423257;4238.682098842599;3800.923981520354;3801.1067399161175;3802.2015376770637;3837.2325534893134;3848.422736589478;4882.048000639912;5107.131787596118;5150.175971844487;5189.896202075937;5190.81832135881;5566.721663916788;5569.331680198402;5579.13523403873;5585.385607583163;5594.049011667945;5030.522100400456;5166.3800343958965;5198.090334191577;5200.167973124282;5245.6852588844795;4710;4722.126406614787;4750.07373562152;4784.162771514971;4788.11419887322;5689.487946084872;5693.060644993612;5696.572757043238;5703.458171473703;5749.827505174768;5474.397816240131;5475.780968761364;5486.506214440719;5488.588355873246;5572.721363931706;5748.310202775694;5768.480836724715;5770.855728606818;5782.7686892523825;5814.069748840166;5469.72651367438;5472.34331880161;5478.780848766005;5481.698506582016;5484.725763711878;5367.785288588413;5501.834944951658;5505.339359276913;5535.833924982257;5553.416891226525;5312.840614781563;5313.707746074003;5322.281491998686;5330.733463326896;5376.704281264568;5267.604929630216;5282.762275697526;5294.285271488454;5298.2052692096495;5331.840044798662;5199.246109314204;5230.97384513075;5249.947500525099;5331.733413329241;5341.866453338697;5235.031519168966;5244.554212891947;5245.423003469539;5246.239295302236;5262.684238945675;5127.692338459704;5174.223866420067;5182.585393168612;5184.662996905189;5241.0042092002395 17:28:49 INFO - PROCESS | 9120 | |1;ext.html;501.8193450357871;522.736018310753;533.9332583427072;537.7553213287954;555.4140381897099;27619.861900690492;35982.2803543929;36227.637723622756;36249.91250262493;36824.63175368246;39442.211155776866;39881;39890.601093989055;39931.20137597254;39960.80019599898;7448.3668888144575;8354.456960297577;8549.358798090137;9879.555420006118;10014.248931330143;9933.155681767023;10095.899041009607;10097.697069087939;10098.242631802645;10100.393976361405;10099.495025248745;10158.085772280494;10204.030617091365;10211.948940255288;10238.948805255963;9901.35641183328;9993.85009224855;10023.248256380728;10028.348157369748;10089.949550252239;9826.459544725038;9998.650047248384;10113.443760593165;10286;10317.896821031844;39981.40027899584;40382.39426408606;40417;40419.59580404188;40423.19153616911;3335.0828522156357;3742.1393079591576;4004.659603933669;4020.718549701522;4161.126163505667;30131.397372052656;30331.93838215674;30365.392692146033;30387.696123038928;30432.543511847118;3840.1759164396967;3899.8050097495297;4019.678425725935;4120.773357465338;4143.6892233082635;184306;184433.99999999866;184653.99999999866;184709.07645461822;185578;48691.26963095556;49037.509624903294;49170.75414622904;49207.50792492029;49331.50668493269;52676;53139;53147.73426132845;53167.20249196265;53252;14729.852701472848;14953.40186392532;15368.308426120851;15445.922770386302;15463.768043479356;10373.636922707668;10375.27373083892;10381.325213861075;10387.896121038693;10390.960903909549;18099.195506982363;19286.61426771485;19415.054788940946;19500.70748938767;19528.256166594132;6012.458878700851;7260.38286745622;7532.4442318043575;7605.847883042419;7642.770716878391;936.2276122199213;948.5778828421425;950.705281362766;989.7179303898355;1011.6661501704419;28365;28758;29051.22334096554;29178.69194842003;29421.705782942325;1018.908298253146;1032.5869652139054;1083.685731137961;1112.1047556716758;1120.6862078618;14561;15134.772978405334;15184;15310.693786124215;15363.385464581292;307785;310078;310738;311556;311791;52466;52769.472305277224;52785.2082218767;52824.207636885476;52846.735766320926;1155.3876445483907;1320.8414990201238;1335.9933200333935;1349.966250843717;1356.1185229600837;25170.62244066377;26537;26900.192994210203;26911.596326054732;27201.86399067992;40015.79992100021;49634.25548616846;50382.74808625934;50553.49446505488;50572;204583;205074;205152;206322;206401;27988.16035518938;31818.68181318157;31906.36187276288;32379.35241295208;32784.50823237701;38940.30067143617;43730;43874.34188487239;43959.78020110007;44633;32618.673813262514;33314.66685333115;33431.83284083564;34008.31983360369;34306.48540271848;32069.198270043435;32298.93160149782;32942.67057329492;33143.83428082844;33598.83200583982;34895.47656785201;35653;35943.92168234957;36222.8188859054;36227;28323.50017235118;31868.5219721709;32073.67926320707;32412.35175296528;32509;24444.266671999867;24717.25848224556;24753.87623061873;25088.498230034933;25128.37179070465 17:28:49 INFO - PROCESS | 9120 | |2;jquery.html;351.54299410766015;356.3727839003353;358.4354641439732;365.4408754605451;367.8289595338167;16885.24016419261;16942.5764355891;18152.36466723665;18156.909215453903;18159.18283677233;16988.660226795455;17030.659386812255;17439.82560174401;17447.563810904703;17458.56353591161;5131.281620573122;5366.329208848894;5447.237386765856;5451.100568406208;5455.945440545584;3955.564887862333;5366.382865970405;5601.635893666919;5993.760249590011;6045.214122164112;5917.260342457193;5959.1359252908305;5964.19483369746;6002.099685047234;6006.339302676702;5723.742431590567;6030.306514750794;6034.788782392639;6040.697965101749;6041.6375017499095;3620.25784714133;5141.5886729061585;5331.306930099101;5361.142217245222;5373.167159090308;20943.05756240973;20975;21258.574828503344;22307;22442.77557224423;2085.895705214733;2114.1860383752214;2219.5006123622215;2260.536589999046;2340.075670110297;12749.936250318782;13122;13279.336033198399;13312.933435332858;13481;1832.5594316783793;1904.8952307623076;1909.9618007639908;1943.3004118517322;1982.544014876572;65332.346676533576;66938;67086.9999999995;68026.65986670036;69489;10044.849327260097;10047.949760251298;10352.792944141074;10468.63359782404;10675.786484270271;13890.166590004632;13919.703248963808;13973;13993.440262389391;14032.649183770283;7400.555966642019;7847.489913155627;7872.055353357634;7910.683572657144;8017.278444939983;7639.159692433828;7665.118511371152;7738.303552680286;7793.688252469951;7800.531968081933;6200.100985357189;6291.874162516724;6304.653244071528;6317.936820631735;6319.58922670025;1716.6223430845193;1786.580153663888;1795.3267524678245;1798.7678440268458;1798.9132606176772;922.064104933493;982.1553464020936;1002.3434650304063;1031.6492392586556;1045.7856139491387;17184.484465466056;17829.7325540117;18140.63718725618;18182.090895455174;18400.539986500444;895.6788736613443;924;940.1726480696943;940.9059094090536;1011.2870426349554;9953.502324883726;10392.37645741258;10412.5834966602;10431.68704938853;10446.582136714598;370744;371017;388694;389692;390896;76126.61936690281;76128.61935690398;77896;79665;79872;1034.5861655337926;1040.8178568750438;1089.8256278995323;1107.645553422897;1107.6566264458045;15672.294746736196;15936.362545498514;15955.361785528448;16103.919480402992;16157.4344897928;34066;34284.14289642779;34459.82770086134;34693.30613387668;35387.46918796271;46714;47545.28682069702;47573.76213118912;48319.20169579673;48449.27326090182;10194.490275486345;11426.314421134759;11449.885501144881;11662.416879156179;11704.882951170379;12849;12922.935385323013;13174.802377964146;13244.933775331061;13622.38699258516;10771.676849694522;11124.443777810915;11473.541058357572;11726.765464690829;11739.471723772622;11260.549578017115;11505.712357191138;11644.2431241969;11746.236494627821;11773;11273.478080459034;11392.601258955896;11882.940585297018;11994.64016079519;12089.335086570323;10715.678529644123;10756.408397537898;10827.296225745302;10874.891251087703;11201.551937922392;11412.201145919706;11439.885601143882;11699.590514332298;11869.287842729464;11958.342291173722 17:28:49 INFO - PROCESS | 9120 | |3;mootools.html;1313.678148853531;1443.1990245413797;1456.7887656289836;1625.2605064695565;1806.1420825108075;7217.7112915483385;7379.778606641796;7397.408207343399;7423.072115985502;7425.814354641137;7669.309762121408;7846.72536461224;7848;7853.253940875622;7865.134835168127;2008.658528050235;2056.5578400643935;2254.785795349447;2337.4273303040736;2361.9055237790467;2303.1133013789727;2307.0195167054017;2308.376738280663;2313.7223533175957;2314.0743702519044;2261.683364328995;2264.2527965771337;2337.1002164166835;2340.1458467659268;2371.1108334374608;2302.7582103879017;2336.894839732208;2337.5792357375667;2344.085806535444;2348.2602980061397;2288.084766093559;2302.850314729554;2304.9078036878504;2308.90764369425;2311.4336987438187;7929.841403171962;8007.67969281228;8022.839543209161;8033.839323213561;8040.276375126266;4790.401199850019;4927.088488629579;4963.8262660806695;4965.354503914504;4965.577925876305;3078.9993252193126;3098.612673415823;3120.7659425542947;3138.73320767735;3236.514522821572;950.097407462913;971.0386717150042;973.2214228617078;975.5219942228327;1009.1724785675749;11162.832557511643;11221.607243746512;11227.045701115416;11246.55013799447;11257.943710281395;4304.3543468479975;4453.910921781546;4492.191405547033;4509.368688383629;4521.660875434355;9441.15029647335;9464.574094165779;9468.668596599086;9471.621135154517;9524.047595240421;4955.727434991038;4988.775505102279;4994.9750251248515;5004.774785134678;5006.64953453262;3912.158885839558;4321.2005778931;4403.691741578123;4406.845760398371;4461.955380446219;3720.8883733488037;3795.6773674237447;3798.9430158547643;3805.219929914361;3854.036490877281;1218.6831423829867;1218.9634310970685;1224.3266203587991;1233.9197952133084;1254.4166962362544;1246.931418771958;1256.2525297448003;1269.4097244781037;1341.7651910915552;1345.0114166087917;7456.142543607554;7468.103827540621;7484.887726684104;7497.925020749832;7575.621218939141;476.3355119608127;483.7484508055791;486.0352200881248;487.06240487062973;489.81631888041983;5495.807646732345;5516.3380394352935;5525.4474552545225;5558.166275058693;5564.66612003273;9337.299702522338;9617.326787124974;9760.023997600325;9883.505824708736;9921.900780992242;9597.712068637951;9647.517624118766;9654.227661787181;9734.659286924923;9802.166815820736;7353.926460735431;7522.3605993491165;7562.924370756442;7596.886046709304;7601.315881570575;7225;7233.168185658506;7263.237360077327;7304.96347518259;7312.1591017033725;8551.102134275812;8651.826963460822;8708.085651006553;8709.346798989975;8719.91280087191;8614.483131012159;8735.126487351214;8880.378373513791;8918.24194943437;9070.092990700878;6245.6252624842655;6613;6878.105846239957;7078.787636370917;7156.606386648576;7533.322001019935;7541.2458754124145;7543.698252070075;7548.320651141204;7559.357454616199;6711.798646040626;6837.829054273683;6914.101166848278;6999.720011199699;7108.715651374094;6831.9658401707675;6887.93112068893;6926.619035953071;7027.191872934473;7041.295870412918;7142.500024998408;7166.247544007804;7170.928290717235;7267.418606511361;7294.416446684359;6433.356664333529;6444.7744328948265;6461.2892581816905;6466.094746735367;6503.772367967098;6360.49116070704;6640.667966601554;6642.933570664231;6657.40083392497;6703.162104736908 17:28:49 INFO - PROCESS | 9120 | |4;prototype.html;338.80349397349534;340.419584608243;344.6432941905128;348.904051385869;350.8842082112901;5904.704764761761;5908.940910590898;5926.111083337496;5953.047512398017;5973.432523910222;5906.173135760997;5912.940870591293;5913.852153696149;5915.704214789265;5934.228550288467;4366.868993930179;4452.666050046243;4546.045330480603;4553.043860789238;4615.699979501338;4580.702254353473;4585.518520555327;4597.977010114945;4612.3542704021465;4614.769261536927;4351.434313539251;4547.613452856494;4553.134904368176;4563.178627846986;4568.885777855547;4423.447069116361;4496.730196188223;4512.075024619945;4560.612347950429;4567.566081222279;4012.0972781124306;4018.2365350583586;4021.537523184842;4028.7179897407195;4030.8186131624147;5633.774649014075;5639.464250896158;5642.576806739511;5649.0396632572565;5663.405342439067;5347.331583552056;5347.652402593858;5350.250964864922;5351.304330437058;5355.732213389354;6285.2771931228035;6304.7793327233785;6330.905036424458;6331.303556608769;6335.176427064452;4390.956090439086;4493.5506449355125;4508.819647214107;4514.706544074625;4515.661325400608;6537.248216455074;6569.770058047993;6570.178727659043;6578.407943285079;6583.967080164616;4612.492625811158;4613.653975951817;4617.353570500132;4620;4632.490426053131;4674.485806561275;4675.438947326343;4677;4680.297955306663;4682.344471773954;5332.9733351333;5341.866453338697;5347.0909945309395;5348.786048558014;5356.1697936819855;6212.4408803207925;6358.300586935434;6361.141245931833;6377.904331435032;6382.680865956683;1625.3986025170761;1630.7879975603096;1646.0864220357578;1651.7604947282578;1655.213773457598;1052.3422860712055;1079.9784004320027;1092.0390056750168;1121.5738019552518;1146.827975803636;5930.970345148246;5941.940580594225;5948.315943666534;5948.613340132964;5967.940320596826;6424.453921416639;6450.0647406125845;6455.483561315177;6463.095166676669;6464.25661048976;5916;5961.076033214858;5986.102084687332;5988.101784732238;5992.550558708114;3430.3139372125675;3471.8437670304897;3473.340065387619;3476.5480487536456;3477.4957631143343;6511.544191906521;6720.32796720324;6732.360425759545;6774.796756097325;6827.863442731217;6568.211814582281;6580.144581204413;6591.901121483182;6596.142501474777;6601.009848522664;6733.7643182489355;6734.259231484532;6746.730130794811;6752.358525940126;6753.425958793558;6414.550981431255;6415.903761443676;6425.9036114457385;6434.324395938359;6434.967825160844;5821.243238378984;6121.265448146251;6319.747210111544;6380.298167201511;6395.456386207225;6631.966840165768;6803.319668033157;6860.211075726155;6869.003994420881;6880.862382752217;4628.67599268048;4630.212863813227;4631.305304204397;4649.465311489222;4653.650976176733;6528.445082168069;6539.280679125197;6540.345965403421;6549.574277671936;6575.704093315908;6344.080108384351;6348.841278967878;6357.523185760994;6359;6360.459360954371;6182.6599537025895;6347.460465860454;6374.968125159345;6405.19935008124;6430.582012169194;6210.068489726577;6277.466415354564;6279.466245369012;6282.842928926813;6288.213973253343;6386.776462823779;6390.840228994312;6463.935360646334;6470.547061705635;6476.190476190476;5984.670843103671;6116.969415153074;6263.279722831932;6274.058891166362;6277.089821975879 17:28:49 INFO - PROCESS | 9120 | |5;yui.html;700.8318003679116;782.3193821375404;801.6232370785729;821.6384790692099;828.449081360895;13735.175889446627;13955.906614007903;13957.930210348959;14024.01831871768;14040.859591404096;14653.706925861476;14944.40222391103;14962.850371496283;14975.625609359771;14983.92508037461;696.6377483708469;830.0661755525049;839.86562150056;844.6536919862857;845.5687599324358;843.9198276163754;847.4491580472711;847.6990668312752;847.7541512961234;850.1201256699318;896.5024411451642;901.3555307954811;902.4900930974012;902.5351943748974;902.7246689759621;720.125048066599;870.8954925408959;889.4174315823146;890.4612709310838;895.9731208063736;653.8986457099157;656.8193746719691;658.410722403451;659.9439047680953;662.8243515468405;13886;13976.231307278096;13983.720325593533;14020.088694234842;14054.648633784238;12577.496900123984;12715.427805748763;12967.157134786208;13002.934985325108;13268.86731132686;10908.454577271184;10953.671389858317;10973.23187376884;11028.558857645685;11063.778724425467;3531.682148606638;3541.7009130714005;3701.056230661191;3726.888193354204;3736;51050.23424648633;51174;51524;51578.7421062896;51687.22469163003;10082.69751907444;10290.3825770454;10379.688609341732;10448.798388185303;10913.672589822318;18863.811361886204;18887.433376998713;18892.33876814305;18900.527486812938;18917;7844.097928738268;8024.638891249908;8043.075046369625;8066.15305392937;8089.716859909875;4387.078713470143;4559.863204103882;4594;4633.6524760642415;4780.402449693788;3127.796693214934;3135.8902438415003;3147.984260078685;3151.936961260762;3155.6213254409618;497.2193655960108;557.5316733943507;584.1704779213527;588.7027051339046;589.1192666962833;539.970301633406;640.50040968045;682.8728510689267;689.9137607799025;690.0718533572337;7735.690572377154;8084.1107478177355;8392.580370981426;8423.284020858173;8629.784255393666;608.2245137449787;643.2955913274957;645.3901063495045;666.8199586111723;672.5729161982176;3884.320243957296;3899.5905429930017;3915.647591716759;3920.6863450923856;3980.5024371953505;58104.4189558099;58850.411495885346;59312;59375;59527.702361487914;51954;52469;52681.473185267656;53126.46873531293;53226;46716.76641616838;47366;47370.5262947373;47637.28544071842;48395.5160448398;7826.7651970440975;7830.4518683691595;7923.564203968837;7986;8067.798305042421;34854;35623.64376356203;36003.63996360003;36581.63418365889;36936.26127477489;41784.79107604564;41862.581374185866;44015.11969760651;45547.77226113848;46086;10906.291091079054;10910.290831095954;10995.120390368591;11163.609273675382;11488.597899073493;10358.792824143626;10510.579576816841;10856.45717714127;11733.706657333634;11749.941250293694;10737.946310268399;10956.945215273872;11217.439128043728;11227.943860280646;11596.594119205787;10954.561817527529;11278;11512.82730759056;11530.76938461243;11541.653750387502;10197.337173083726;10367.94816025915;10474.947625261824;10939.343639381663;11131.220814543229;8956.507392093497;8958.328125390492;9246.768830779016;9401.482918439278;9594.18449431806;7647.235276472308;8076.959615201887;8627.95686021566;9022.233110185707;9769.43689009755 17:28:49 INFO - PROCESS | 9120 | __end_tp_report 17:28:49 INFO - PROCESS | 9120 | __start_cc_report 17:28:49 INFO - PROCESS | 9120 | _x_x_mozilla_cycle_collect,818 17:28:49 INFO - PROCESS | 9120 | __end_cc_report 17:28:49 INFO - PROCESS | 9120 | __startTimestamp1457141329212__endTimestamp 17:28:49 INFO - PROCESS | 9120 | 17:28:49 INFO - PROCESS | 9120 | ------- Summary: start ------- 17:28:49 INFO - PROCESS | 9120 | Number of tests: 6 17:28:49 INFO - PROCESS | 9120 | 17:28:49 INFO - PROCESS | 9120 | [#0] dojo.html Cycles:165 Average:5117.62 Median:5245.69 stddev:562.97 (10.7%) stddev-sans-first:540.96 17:28:49 INFO - PROCESS | 9120 | Values: 3055.9 3116.8 3153.7 3165.2 3175.6 5029.2 5083.2 5113.9 5138.5 5152.8 5150.5 5194.4 5198.4 5207.1 5230.5 4654.4 4658.5 4708.1 4717.5 4756.7 4661.5 4673.6 4693.1 4716.6 4778.7 4590.6 4637.3 4640.3 4642.5 4680.6 4695.7 4748.3 4748.8 4752.9 4789.9 4465.0 4675.2 4726.6 4727.7 4755.8 5011.6 5060.6 5067.2 5092.1 5109.6 5468.0 5472.2 5474.0 5478.9 5484.4 5515.5 5521.0 5569.9 5572.7 5583.8 5227.3 5240.2 5244.6 5270.4 5290.3 5711.5 5717.0 5717.7 5719.0 5738.9 5384.4 5465.2 5504.2 5517.7 5520.6 5557.1 5560.7 5563.9 5569.6 5580.5 5509.8 5524.2 5527.9 5527.9 5533.7 5341.5 5399.4 5433.9 5439.4 5561.5 4192.2 4197.0 4209.1 4233.0 4238.7 3800.9 3801.1 3802.2 3837.2 3848.4 4882.0 5107.1 5150.2 5189.9 5190.8 5566.7 5569.3 5579.1 5585.4 5594.0 5030.5 5166.4 5198.1 5200.2 5245.7 4710.0 4722.1 4750.1 4784.2 4788.1 5689.5 5693.1 5696.6 5703.5 5749.8 5474.4 5475.8 5486.5 5488.6 5572.7 5748.3 5768.5 5770.9 5782.8 5814.1 5469.7 5472.3 5478.8 5481.7 5484.7 5367.8 5501.8 5505.3 5535.8 5553.4 5312.8 5313.7 5322.3 5330.7 5376.7 5267.6 5282.8 5294.3 5298.2 5331.8 5199.2 5231.0 5249.9 5331.7 5341.9 5235.0 5244.6 5245.4 5246.2 5262.7 5127.7 5174.2 5182.6 5184.7 5241.0 17:28:49 INFO - PROCESS | 9120 | 17:28:49 INFO - PROCESS | 9120 | [#1] ext.html Cycles:180 Average:40698.07 Median:32339.14 stddev:62479.86 (193.2%) stddev-sans-first:62582.24 17:28:49 INFO - PROCESS | 9120 | Values: 501.8 522.7 533.9 537.8 555.4 27619.9 35982.3 36227.6 36249.9 36824.6 39442.2 39881.0 39890.6 39931.2 39960.8 7448.4 8354.5 8549.4 9879.6 10014.2 9933.2 10095.9 10097.7 10098.2 10100.4 10099.5 10158.1 10204.0 10211.9 10238.9 9901.4 9993.9 10023.2 10028.3 10089.9 9826.5 9998.7 10113.4 10286.0 10317.9 39981.4 40382.4 40417.0 40419.6 40423.2 3335.1 3742.1 4004.7 4020.7 4161.1 30131.4 30331.9 30365.4 30387.7 30432.5 3840.2 3899.8 4019.7 4120.8 4143.7 184306.0 184434.0 184654.0 184709.1 185578.0 48691.3 49037.5 49170.8 49207.5 49331.5 52676.0 53139.0 53147.7 53167.2 53252.0 14729.9 14953.4 15368.3 15445.9 15463.8 10373.6 10375.3 10381.3 10387.9 10391.0 18099.2 19286.6 19415.1 19500.7 19528.3 6012.5 7260.4 7532.4 7605.8 7642.8 936.2 948.6 950.7 989.7 1011.7 28365.0 28758.0 29051.2 29178.7 29421.7 1018.9 1032.6 1083.7 1112.1 1120.7 14561.0 15134.8 15184.0 15310.7 15363.4 307785.0 310078.0 310738.0 311556.0 311791.0 52466.0 52769.5 52785.2 52824.2 52846.7 1155.4 1320.8 1336.0 1350.0 1356.1 25170.6 26537.0 26900.2 26911.6 27201.9 40015.8 49634.3 50382.7 50553.5 50572.0 204583.0 205074.0 205152.0 206322.0 206401.0 27988.2 31818.7 31906.4 32379.4 32784.5 38940.3 43730.0 43874.3 43959.8 44633.0 32618.7 33314.7 33431.8 34008.3 34306.5 32069.2 32298.9 32942.7 33143.8 33598.8 34895.5 35653.0 35943.9 36222.8 36227.0 28323.5 31868.5 32073.7 32412.4 32509.0 24444.3 24717.3 24753.9 25088.5 25128.4 17:28:49 INFO - PROCESS | 9120 | 17:28:49 INFO - PROCESS | 9120 | [#2] jquery.html Cycles:180 Average:24680.45 Median:1926.63 stddev:62948.06 (3267.3%) stddev-sans-first:63098.15 17:28:49 INFO - PROCESS | 9120 | Values: 351.5 356.4 358.4 365.4 367.8 16885.2 16942.6 18152.4 18156.9 18159.2 16988.7 17030.7 17439.8 17447.6 17458.6 5131.3 5366.3 5447.2 5451.1 5455.9 3955.6 5366.4 5601.6 5993.8 6045.2 5917.3 5959.1 5964.2 6002.1 6006.3 5723.7 6030.3 6034.8 6040.7 6041.6 3620.3 5141.6 5331.3 5361.1 5373.2 20943.1 20975.0 21258.6 22307.0 22442.8 2085.9 2114.2 2219.5 2260.5 2340.1 12749.9 13122.0 13279.3 13312.9 13481.0 1832.6 1904.9 1910.0 1943.3 1982.5 65332.3 66938.0 67087.0 68026.7 69489.0 10044.8 10047.9 10352.8 10468.6 10675.8 13890.2 13919.7 13973.0 13993.4 14032.6 7400.6 7847.5 7872.1 7910.7 8017.3 7639.2 7665.1 7738.3 7793.7 7800.5 6200.1 6291.9 6304.7 6317.9 6319.6 1716.6 1786.6 1795.3 1798.8 1798.9 922.1 982.2 1002.3 1031.6 1045.8 17184.5 17829.7 18140.6 18182.1 18400.5 895.7 924.0 940.2 940.9 1011.3 9953.5 10392.4 10412.6 10431.7 10446.6 370744.0 371017.0 388694.0 389692.0 390896.0 76126.6 76128.6 77896.0 79665.0 79872.0 1034.6 1040.8 1089.8 1107.6 1107.7 15672.3 15936.4 15955.4 16103.9 16157.4 34066.0 34284.1 34459.8 34693.3 35387.5 46714.0 47545.3 47573.8 48319.2 48449.3 10194.5 11426.3 11449.9 11662.4 11704.9 12849.0 12922.9 13174.8 13244.9 13622.4 10771.7 11124.4 11473.5 11726.8 11739.5 11260.5 11505.7 11644.2 11746.2 11773.0 11273.5 11392.6 11882.9 11994.6 12089.3 10715.7 10756.4 10827.3 10874.9 11201.6 11412.2 11439.9 11699.6 11869.3 11958.3 17:28:49 INFO - PROCESS | 9120 | 17:28:49 INFO - PROCESS | 9120 | [#3] mootools.html Cycles:180 Average:5546.13 Median:6463.69 stddev:2928.45 (45.3%) stddev-sans-first:2919.39 17:28:49 INFO - PROCESS | 9120 | Values: 1313.7 1443.2 1456.8 1625.3 1806.1 7217.7 7379.8 7397.4 7423.1 7425.8 7669.3 7846.7 7848.0 7853.3 7865.1 2008.7 2056.6 2254.8 2337.4 2361.9 2303.1 2307.0 2308.4 2313.7 2314.1 2261.7 2264.3 2337.1 2340.1 2371.1 2302.8 2336.9 2337.6 2344.1 2348.3 2288.1 2302.9 2304.9 2308.9 2311.4 7929.8 8007.7 8022.8 8033.8 8040.3 4790.4 4927.1 4963.8 4965.4 4965.6 3079.0 3098.6 3120.8 3138.7 3236.5 950.1 971.0 973.2 975.5 1009.2 11162.8 11221.6 11227.0 11246.6 11257.9 4304.4 4453.9 4492.2 4509.4 4521.7 9441.2 9464.6 9468.7 9471.6 9524.0 4955.7 4988.8 4995.0 5004.8 5006.6 3912.2 4321.2 4403.7 4406.8 4462.0 3720.9 3795.7 3798.9 3805.2 3854.0 1218.7 1219.0 1224.3 1233.9 1254.4 1246.9 1256.3 1269.4 1341.8 1345.0 7456.1 7468.1 7484.9 7497.9 7575.6 476.3 483.7 486.0 487.1 489.8 5495.8 5516.3 5525.4 5558.2 5564.7 9337.3 9617.3 9760.0 9883.5 9921.9 9597.7 9647.5 9654.2 9734.7 9802.2 7353.9 7522.4 7562.9 7596.9 7601.3 7225.0 7233.2 7263.2 7305.0 7312.2 8551.1 8651.8 8708.1 8709.3 8719.9 8614.5 8735.1 8880.4 8918.2 9070.1 6245.6 6613.0 6878.1 7078.8 7156.6 7533.3 7541.2 7543.7 7548.3 7559.4 6711.8 6837.8 6914.1 6999.7 7108.7 6832.0 6887.9 6926.6 7027.2 7041.3 7142.5 7166.2 7170.9 7267.4 7294.4 6433.4 6444.8 6461.3 6466.1 6503.8 6360.5 6640.7 6642.9 6657.4 6703.2 17:28:49 INFO - PROCESS | 9120 | 17:28:49 INFO - PROCESS | 9120 | [#4] prototype.html Cycles:180 Average:5292.64 Median:5938.08 stddev:1574.16 (26.5%) stddev-sans-first:1534.04 17:28:49 INFO - PROCESS | 9120 | Values: 338.8 340.4 344.6 348.9 350.9 5904.7 5908.9 5926.1 5953.0 5973.4 5906.2 5912.9 5913.9 5915.7 5934.2 4366.9 4452.7 4546.0 4553.0 4615.7 4580.7 4585.5 4598.0 4612.4 4614.8 4351.4 4547.6 4553.1 4563.2 4568.9 4423.4 4496.7 4512.1 4560.6 4567.6 4012.1 4018.2 4021.5 4028.7 4030.8 5633.8 5639.5 5642.6 5649.0 5663.4 5347.3 5347.7 5350.3 5351.3 5355.7 6285.3 6304.8 6330.9 6331.3 6335.2 4391.0 4493.6 4508.8 4514.7 4515.7 6537.2 6569.8 6570.2 6578.4 6584.0 4612.5 4613.7 4617.4 4620.0 4632.5 4674.5 4675.4 4677.0 4680.3 4682.3 5333.0 5341.9 5347.1 5348.8 5356.2 6212.4 6358.3 6361.1 6377.9 6382.7 1625.4 1630.8 1646.1 1651.8 1655.2 1052.3 1080.0 1092.0 1121.6 1146.8 5931.0 5941.9 5948.3 5948.6 5967.9 6424.5 6450.1 6455.5 6463.1 6464.3 5916.0 5961.1 5986.1 5988.1 5992.6 3430.3 3471.8 3473.3 3476.5 3477.5 6511.5 6720.3 6732.4 6774.8 6827.9 6568.2 6580.1 6591.9 6596.1 6601.0 6733.8 6734.3 6746.7 6752.4 6753.4 6414.6 6415.9 6425.9 6434.3 6435.0 5821.2 6121.3 6319.7 6380.3 6395.5 6632.0 6803.3 6860.2 6869.0 6880.9 4628.7 4630.2 4631.3 4649.5 4653.7 6528.4 6539.3 6540.3 6549.6 6575.7 6344.1 6348.8 6357.5 6359.0 6360.5 6182.7 6347.5 6375.0 6405.2 6430.6 6210.1 6277.5 6279.5 6282.8 6288.2 6386.8 6390.8 6463.9 6470.5 6476.2 5984.7 6117.0 6263.3 6274.1 6277.1 17:28:49 INFO - PROCESS | 9120 | 17:28:49 INFO - PROCESS | 9120 | [#5] yui.html Cycles:180 Average:14051.79 Median:47368.26 stddev:16437.48 (34.7%) stddev-sans-first:16453.01 17:28:49 INFO - PROCESS | 9120 | Values: 700.8 782.3 801.6 821.6 828.4 13735.2 13955.9 13957.9 14024.0 14040.9 14653.7 14944.4 14962.9 14975.6 14983.9 696.6 830.1 839.9 844.7 845.6 843.9 847.4 847.7 847.8 850.1 896.5 901.4 902.5 902.5 902.7 720.1 870.9 889.4 890.5 896.0 653.9 656.8 658.4 659.9 662.8 13886.0 13976.2 13983.7 14020.1 14054.6 12577.5 12715.4 12967.2 13002.9 13268.9 10908.5 10953.7 10973.2 11028.6 11063.8 3531.7 3541.7 3701.1 3726.9 3736.0 51050.2 51174.0 51524.0 51578.7 51687.2 10082.7 10290.4 10379.7 10448.8 10913.7 18863.8 18887.4 18892.3 18900.5 18917.0 7844.1 8024.6 8043.1 8066.2 8089.7 4387.1 4559.9 4594.0 4633.7 4780.4 3127.8 3135.9 3148.0 3151.9 3155.6 497.2 557.5 584.2 588.7 589.1 540.0 640.5 682.9 689.9 690.1 7735.7 8084.1 8392.6 8423.3 8629.8 608.2 643.3 645.4 666.8 672.6 3884.3 3899.6 3915.6 3920.7 3980.5 58104.4 58850.4 59312.0 59375.0 59527.7 51954.0 52469.0 52681.5 53126.5 53226.0 46716.8 47366.0 47370.5 47637.3 48395.5 7826.8 7830.5 7923.6 7986.0 8067.8 34854.0 35623.6 36003.6 36581.6 36936.3 41784.8 41862.6 44015.1 45547.8 46086.0 10906.3 10910.3 10995.1 11163.6 11488.6 10358.8 10510.6 10856.5 11733.7 11749.9 10737.9 10956.9 11217.4 11227.9 11596.6 10954.6 11278.0 11512.8 11530.8 11541.7 10197.3 10367.9 10474.9 10939.3 11131.2 8956.5 8958.3 9246.8 9401.5 9594.2 7647.2 8077.0 8628.0 9022.2 9769.4 17:28:49 INFO - PROCESS | 9120 | -------- Summary: end -------- 17:28:49 INFO - PROCESS | 9120 | 17:28:49 INFO - TEST-INFO | 9120: exit 0 17:28:49 INFO - TEST-OK | dromaeo_css | took 1113280ms 17:28:49 INFO - TEST-START | kraken 17:28:49 INFO - operating with platform_type : linux_ 17:28:49 INFO - Initialising browser for kraken test... 17:28:49 INFO - TEST-INFO | started process 9308 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzPnJgi/profile http://localhost:39074/getInfo.html) 17:28:54 INFO - PROCESS | 9308 | __metrics Screen width/height:1600/1200 17:28:54 INFO - PROCESS | 9308 | colorDepth:24 17:28:54 INFO - PROCESS | 9308 | Browser inner width/height: 1024/697 17:28:54 INFO - PROCESS | 9308 | __metrics 17:28:55 INFO - PROCESS | 9308 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:28:56 INFO - TEST-INFO | 9308: exit 0 17:28:56 INFO - Browser initialized. 17:28:56 INFO - Running cycle 1/1 for kraken test... 17:28:56 INFO - TEST-INFO | started process 9390 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzPnJgi/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:29:07 INFO - PROCESS | 9390 | RSS: Main: 153722880 17:29:07 INFO - PROCESS | 9390 | 17:29:10 INFO - PROCESS | 9390 | Cycle 1(1): loaded http://localhost:39074/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39074/tests/kraken/driver.html?testName=audio-beat-detection) 17:29:10 INFO - PROCESS | 9390 | RSS: Main: 196452352 17:29:10 INFO - PROCESS | 9390 | 17:29:13 INFO - PROCESS | 9390 | Cycle 1(1): loaded http://localhost:39074/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39074/tests/kraken/driver.html?testName=audio-dft) 17:29:14 INFO - PROCESS | 9390 | RSS: Main: 188436480 17:29:14 INFO - PROCESS | 9390 | 17:29:17 INFO - PROCESS | 9390 | Cycle 1(1): loaded http://localhost:39074/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39074/tests/kraken/driver.html?testName=audio-fft) 17:29:17 INFO - PROCESS | 9390 | RSS: Main: 171491328 17:29:17 INFO - PROCESS | 9390 | 17:29:19 INFO - PROCESS | 9390 | Cycle 1(1): loaded http://localhost:39074/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39074/tests/kraken/driver.html?testName=audio-oscillator) 17:29:20 INFO - PROCESS | 9390 | RSS: Main: 173281280 17:29:20 INFO - PROCESS | 9390 | 17:29:22 INFO - PROCESS | 9390 | Cycle 1(1): loaded http://localhost:39074/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39074/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:29:23 INFO - PROCESS | 9390 | RSS: Main: 174125056 17:29:23 INFO - PROCESS | 9390 | 17:29:26 INFO - PROCESS | 9390 | Cycle 1(1): loaded http://localhost:39074/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39074/tests/kraken/driver.html?testName=imaging-darkroom) 17:29:26 INFO - PROCESS | 9390 | RSS: Main: 176644096 17:29:26 INFO - PROCESS | 9390 | 17:29:30 INFO - PROCESS | 9390 | Cycle 1(1): loaded http://localhost:39074/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39074/tests/kraken/driver.html?testName=imaging-desaturate) 17:29:30 INFO - PROCESS | 9390 | RSS: Main: 176783360 17:29:30 INFO - PROCESS | 9390 | 17:29:33 INFO - PROCESS | 9390 | Cycle 1(1): loaded http://localhost:39074/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39074/tests/kraken/driver.html?testName=json-parse-financial) 17:29:33 INFO - PROCESS | 9390 | RSS: Main: 175927296 17:29:33 INFO - PROCESS | 9390 | 17:29:35 INFO - PROCESS | 9390 | Cycle 1(1): loaded http://localhost:39074/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39074/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:29:36 INFO - PROCESS | 9390 | RSS: Main: 187830272 17:29:36 INFO - PROCESS | 9390 | 17:29:37 INFO - PROCESS | 9390 | Cycle 1(1): loaded http://localhost:39074/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39074/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:29:38 INFO - PROCESS | 9390 | RSS: Main: 184135680 17:29:38 INFO - PROCESS | 9390 | 17:29:40 INFO - PROCESS | 9390 | Cycle 1(1): loaded http://localhost:39074/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39074/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:29:41 INFO - PROCESS | 9390 | RSS: Main: 196435968 17:29:41 INFO - PROCESS | 9390 | 17:29:43 INFO - PROCESS | 9390 | Cycle 1(1): loaded http://localhost:39074/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39074/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:29:44 INFO - PROCESS | 9390 | RSS: Main: 201023488 17:29:44 INFO - PROCESS | 9390 | 17:29:46 INFO - PROCESS | 9390 | Cycle 1(1): loaded http://localhost:39074/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39074/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:29:47 INFO - PROCESS | 9390 | RSS: Main: 200712192 17:29:47 INFO - PROCESS | 9390 | 17:29:49 INFO - PROCESS | 9390 | Cycle 1(1): loaded http://localhost:39074/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39074/tests/kraken/driver.html?testName=ai-astar) 17:29:49 INFO - PROCESS | 9390 | RSS: Main: 262631424 17:29:49 INFO - PROCESS | 9390 | 17:29:49 INFO - PROCESS | 9390 | __start_tp_report 17:29:49 INFO - PROCESS | 9390 | _x_x_mozilla_page_load 17:29:49 INFO - PROCESS | 9390 | _x_x_mozilla_page_load_details 17:29:49 INFO - PROCESS | 9390 | |i|pagename|runs| 17:29:49 INFO - PROCESS | 9390 | |0;ai-astar;109;112;107;111;112;112;100;111;111;111 17:29:49 INFO - PROCESS | 9390 | |1;audio-beat-detection;152;127;155;175;127;160;158;129;176;127 17:29:49 INFO - PROCESS | 9390 | |2;audio-dft;161;163;161;161;160;162;163;162;161;161 17:29:49 INFO - PROCESS | 9390 | |3;audio-fft;75;76;104;94;76;72;74;114;94;75 17:29:49 INFO - PROCESS | 9390 | |4;audio-oscillator;92;92;140;93;92;93;146;93;94;142 17:29:49 INFO - PROCESS | 9390 | |5;imaging-gaussian-blur;116;117;117;117;117;117;116;116;117;117 17:29:49 INFO - PROCESS | 9390 | |6;imaging-darkroom;145;146;145;144;146;146;145;145;145;146 17:29:49 INFO - PROCESS | 9390 | |7;imaging-desaturate;95;96;96;97;96;96;96;96;96;96 17:29:49 INFO - PROCESS | 9390 | |8;json-parse-financial;59;59;59;58;60;60;60;68;58;58 17:29:49 INFO - PROCESS | 9390 | |9;json-stringify-tinderbox;66;66;67;67;68;68;66;68;67;69 17:29:49 INFO - PROCESS | 9390 | |10;stanford-crypto-aes;91;83;83;84;83;91;83;83;83;84 17:29:49 INFO - PROCESS | 9390 | |11;stanford-crypto-ccm;120;116;122;113;114;114;117;117;119;116 17:29:49 INFO - PROCESS | 9390 | |12;stanford-crypto-pbkdf2;168;140;155;154;155;140;149;156;141;150 17:29:49 INFO - PROCESS | 9390 | |13;stanford-crypto-sha256-iterative;70;68;69;70;68;74;70;69;69;68 17:29:49 INFO - PROCESS | 9390 | __end_tp_report 17:29:49 INFO - PROCESS | 9390 | __start_cc_report 17:29:49 INFO - PROCESS | 9390 | _x_x_mozilla_cycle_collect,1066 17:29:49 INFO - PROCESS | 9390 | __end_cc_report 17:29:49 INFO - PROCESS | 9390 | __startTimestamp1457141389305__endTimestamp 17:29:49 INFO - PROCESS | 9390 | 17:29:49 INFO - PROCESS | 9390 | ------- Summary: start ------- 17:29:49 INFO - PROCESS | 9390 | Number of tests: 14 17:29:49 INFO - PROCESS | 9390 | 17:29:49 INFO - PROCESS | 9390 | [#0] ai-astar Cycles:10 Average:109.60 Median:111.00 stddev:3.72 (3.3%) stddev-sans-first:3.94 17:29:49 INFO - PROCESS | 9390 | Values: 109.0 112.0 107.0 111.0 112.0 112.0 100.0 111.0 111.0 111.0 17:29:49 INFO - PROCESS | 9390 | 17:29:49 INFO - PROCESS | 9390 | [#1] audio-beat-detection Cycles:10 Average:148.60 Median:156.50 stddev:19.73 (12.6%) stddev-sans-first:20.89 17:29:49 INFO - PROCESS | 9390 | Values: 152.0 127.0 155.0 175.0 127.0 160.0 158.0 129.0 176.0 127.0 17:29:49 INFO - PROCESS | 9390 | 17:29:49 INFO - PROCESS | 9390 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.50 stddev:0.97 (0.6%) stddev-sans-first:1.01 17:29:49 INFO - PROCESS | 9390 | Values: 161.0 163.0 161.0 161.0 160.0 162.0 163.0 162.0 161.0 161.0 17:29:49 INFO - PROCESS | 9390 | 17:29:49 INFO - PROCESS | 9390 | [#3] audio-fft Cycles:10 Average:85.40 Median:75.50 stddev:14.96 (19.8%) stddev-sans-first:15.39 17:29:49 INFO - PROCESS | 9390 | Values: 75.0 76.0 104.0 94.0 76.0 72.0 74.0 114.0 94.0 75.0 17:29:49 INFO - PROCESS | 9390 | 17:29:49 INFO - PROCESS | 9390 | [#4] audio-oscillator Cycles:10 Average:107.70 Median:92.50 stddev:24.18 (26.1%) stddev-sans-first:24.97 17:29:49 INFO - PROCESS | 9390 | Values: 92.0 92.0 140.0 93.0 92.0 93.0 146.0 93.0 94.0 142.0 17:29:49 INFO - PROCESS | 9390 | 17:29:49 INFO - PROCESS | 9390 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 17:29:49 INFO - PROCESS | 9390 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 17:29:49 INFO - PROCESS | 9390 | 17:29:49 INFO - PROCESS | 9390 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.50 stddev:0.67 (0.5%) stddev-sans-first:0.71 17:29:49 INFO - PROCESS | 9390 | Values: 145.0 146.0 145.0 144.0 146.0 146.0 145.0 145.0 145.0 146.0 17:29:49 INFO - PROCESS | 9390 | 17:29:49 INFO - PROCESS | 9390 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 17:29:49 INFO - PROCESS | 9390 | Values: 95.0 96.0 96.0 97.0 96.0 96.0 96.0 96.0 96.0 96.0 17:29:49 INFO - PROCESS | 9390 | 17:29:49 INFO - PROCESS | 9390 | [#8] json-parse-financial Cycles:10 Average:59.90 Median:59.50 stddev:2.96 (5.0%) stddev-sans-first:3.12 17:29:49 INFO - PROCESS | 9390 | Values: 59.0 59.0 59.0 58.0 60.0 60.0 60.0 68.0 58.0 58.0 17:29:49 INFO - PROCESS | 9390 | 17:29:49 INFO - PROCESS | 9390 | [#9] json-stringify-tinderbox Cycles:10 Average:67.20 Median:67.50 stddev:1.03 (1.5%) stddev-sans-first:1.00 17:29:49 INFO - PROCESS | 9390 | Values: 66.0 66.0 67.0 67.0 68.0 68.0 66.0 68.0 67.0 69.0 17:29:49 INFO - PROCESS | 9390 | 17:29:49 INFO - PROCESS | 9390 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:83.50 stddev:3.29 (3.9%) stddev-sans-first:2.62 17:29:49 INFO - PROCESS | 9390 | Values: 91.0 83.0 83.0 84.0 83.0 91.0 83.0 83.0 83.0 84.0 17:29:49 INFO - PROCESS | 9390 | 17:29:49 INFO - PROCESS | 9390 | [#11] stanford-crypto-ccm Cycles:10 Average:116.80 Median:117.00 stddev:2.86 (2.4%) stddev-sans-first:2.79 17:29:49 INFO - PROCESS | 9390 | Values: 120.0 116.0 122.0 113.0 114.0 114.0 117.0 117.0 119.0 116.0 17:29:49 INFO - PROCESS | 9390 | 17:29:49 INFO - PROCESS | 9390 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.80 Median:154.50 stddev:8.83 (5.7%) stddev-sans-first:6.83 17:29:49 INFO - PROCESS | 9390 | Values: 168.0 140.0 155.0 154.0 155.0 140.0 149.0 156.0 141.0 150.0 17:29:49 INFO - PROCESS | 9390 | 17:29:49 INFO - PROCESS | 9390 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:69.50 stddev:1.78 (2.6%) stddev-sans-first:1.88 17:29:49 INFO - PROCESS | 9390 | Values: 70.0 68.0 69.0 70.0 68.0 74.0 70.0 69.0 69.0 68.0 17:29:49 INFO - PROCESS | 9390 | -------- Summary: end -------- 17:29:49 INFO - PROCESS | 9390 | 17:29:50 INFO - TEST-INFO | 9390: exit 0 17:29:50 INFO - TEST-OK | kraken | took 60389ms 17:29:50 INFO - SUITE-END | took 1173s 17:29:50 INFO - Completed test suite (00:19:33) 17:29:50 INFO - javascript benchmark 17:29:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3055.893043743469, 3116.8285744284053, 3153.668864769199, 3165.161232273448, 3175.571297874787, 5029.195328747401, 5083.161278389061, 5113.872153196172, 5138.537531622153, 5152.819651312205, 5150.510701483362, 5194.37667479902, 5198.428172900978, 5207.062728708831, 5230.476952304768, 4654.441467023962, 4658.4642766082, 4708.128996135709, 4717.457492388367, 4756.690815097025, 4661.533846615345, 4673.602743766767, 4693.084848454553, 4716.575508204261, 4778.689385189969, 4590.609798167176, 4637.304404339342, 4640.303954406849, 4642.512536183686, 4680.602148817355, 4695.67130300879, 4748.264019077049, 4748.762561871928, 4752.928706069411, 4789.856304310876, 4464.955350446487, 4675.228587283094, 4726.598239149676, 4727.739974301412, 4755.762211889391, 5011.574016208627, 5060.569851562622, 5067.163917953533, 5092.10888094582, 5109.642325037212, 5467.972660136714, 5472.179173124024, 5474.0, 5478.91781623276, 5484.396716361197, 5515.503604675599, 5521.033819081685, 5569.888602227933, 5572.749226284827, 5583.776648934037, 5227.320448341691, 5240.161574148118, 5244.60665450089, 5270.367555893241, 5290.259363689087, 5711.485966263056, 5717.0, 5717.714114294268, 5719.0, 5738.942610573841, 5384.434634363335, 5465.152901300305, 5504.2294078829, 5517.69652669107, 5520.558355331564, 5557.110862262019, 5560.749766260528, 5563.916541251884, 5569.554435645138, 5580.497755202051, 5509.752061157257, 5524.226608274845, 5527.917081243784, 5527.944720552743, 5533.723313834373, 5341.545968592635, 5399.352077750695, 5433.891322173535, 5439.4288599696465, 5561.499465048165, 4192.24539582878, 4196.979015104966, 4209.116085621992, 4232.957670423257, 4238.682098842599, 3800.923981520354, 3801.1067399161175, 3802.2015376770637, 3837.2325534893134, 3848.422736589478, 4882.048000639912, 5107.131787596118, 5150.175971844487, 5189.896202075937, 5190.81832135881, 5566.721663916788, 5569.331680198402, 5579.13523403873, 5585.385607583163, 5594.049011667945, 5030.522100400456, 5166.3800343958965, 5198.090334191577, 5200.167973124282, 5245.6852588844795, 4710.0, 4722.126406614787, 4750.07373562152, 4784.162771514971, 4788.11419887322, 5689.487946084872, 5693.060644993612, 5696.572757043238, 5703.458171473703, 5749.827505174768, 5474.397816240131, 5475.780968761364, 5486.506214440719, 5488.588355873246, 5572.721363931706, 5748.310202775694, 5768.480836724715, 5770.855728606818, 5782.7686892523825, 5814.069748840166, 5469.72651367438, 5472.34331880161, 5478.780848766005, 5481.698506582016, 5484.725763711878, 5367.785288588413, 5501.834944951658, 5505.339359276913, 5535.833924982257, 5553.416891226525, 5312.840614781563, 5313.707746074003, 5322.281491998686, 5330.733463326896, 5376.704281264568, 5267.604929630216, 5282.762275697526, 5294.285271488454, 5298.2052692096495, 5331.840044798662, 5199.246109314204, 5230.97384513075, 5249.947500525099, 5331.733413329241, 5341.866453338697, 5235.031519168966, 5244.554212891947, 5245.423003469539, 5246.239295302236, 5262.684238945675, 5127.692338459704, 5174.223866420067, 5182.585393168612, 5184.662996905189, 5241.0042092002395], "unit": "score", "name": "dojo.html", "value": 5081.802228383649}, {"lowerIsBetter": false, "replicates": [501.8193450357871, 522.736018310753, 533.9332583427072, 537.7553213287954, 555.4140381897099, 27619.861900690492, 35982.2803543929, 36227.637723622756, 36249.91250262493, 36824.63175368246, 39442.211155776866, 39881.0, 39890.601093989055, 39931.20137597254, 39960.80019599898, 7448.3668888144575, 8354.456960297577, 8549.358798090137, 9879.555420006118, 10014.248931330143, 9933.155681767023, 10095.899041009607, 10097.697069087939, 10098.242631802645, 10100.393976361405, 10099.495025248745, 10158.085772280494, 10204.030617091365, 10211.948940255288, 10238.948805255963, 9901.35641183328, 9993.85009224855, 10023.248256380728, 10028.348157369748, 10089.949550252239, 9826.459544725038, 9998.650047248384, 10113.443760593165, 10286.0, 10317.896821031844, 39981.40027899584, 40382.39426408606, 40417.0, 40419.59580404188, 40423.19153616911, 3335.0828522156357, 3742.1393079591576, 4004.659603933669, 4020.718549701522, 4161.126163505667, 30131.397372052656, 30331.93838215674, 30365.392692146033, 30387.696123038928, 30432.543511847118, 3840.1759164396967, 3899.8050097495297, 4019.678425725935, 4120.773357465338, 4143.6892233082635, 184306.0, 184433.99999999866, 184653.99999999866, 184709.07645461822, 185578.0, 48691.26963095556, 49037.509624903294, 49170.75414622904, 49207.50792492029, 49331.50668493269, 52676.0, 53139.0, 53147.73426132845, 53167.20249196265, 53252.0, 14729.852701472848, 14953.40186392532, 15368.308426120851, 15445.922770386302, 15463.768043479356, 10373.636922707668, 10375.27373083892, 10381.325213861075, 10387.896121038693, 10390.960903909549, 18099.195506982363, 19286.61426771485, 19415.054788940946, 19500.70748938767, 19528.256166594132, 6012.458878700851, 7260.38286745622, 7532.4442318043575, 7605.847883042419, 7642.770716878391, 936.2276122199213, 948.5778828421425, 950.705281362766, 989.7179303898355, 1011.6661501704419, 28365.0, 28758.0, 29051.22334096554, 29178.69194842003, 29421.705782942325, 1018.908298253146, 1032.5869652139054, 1083.685731137961, 1112.1047556716758, 1120.6862078618, 14561.0, 15134.772978405334, 15184.0, 15310.693786124215, 15363.385464581292, 307785.0, 310078.0, 310738.0, 311556.0, 311791.0, 52466.0, 52769.472305277224, 52785.2082218767, 52824.207636885476, 52846.735766320926, 1155.3876445483907, 1320.8414990201238, 1335.9933200333935, 1349.966250843717, 1356.1185229600837, 25170.62244066377, 26537.0, 26900.192994210203, 26911.596326054732, 27201.86399067992, 40015.79992100021, 49634.25548616846, 50382.74808625934, 50553.49446505488, 50572.0, 204583.0, 205074.0, 205152.0, 206322.0, 206401.0, 27988.16035518938, 31818.68181318157, 31906.36187276288, 32379.35241295208, 32784.50823237701, 38940.30067143617, 43730.0, 43874.34188487239, 43959.78020110007, 44633.0, 32618.673813262514, 33314.66685333115, 33431.83284083564, 34008.31983360369, 34306.48540271848, 32069.198270043435, 32298.93160149782, 32942.67057329492, 33143.83428082844, 33598.83200583982, 34895.47656785201, 35653.0, 35943.92168234957, 36222.8188859054, 36227.0, 28323.50017235118, 31868.5219721709, 32073.67926320707, 32412.35175296528, 32509.0, 24444.266671999867, 24717.25848224556, 24753.87623061873, 25088.498230034933, 25128.37179070465], "unit": "score", "name": "ext.html", "value": 17953.556221310235}, {"lowerIsBetter": false, "replicates": [351.54299410766015, 356.3727839003353, 358.4354641439732, 365.4408754605451, 367.8289595338167, 16885.24016419261, 16942.5764355891, 18152.36466723665, 18156.909215453903, 18159.18283677233, 16988.660226795455, 17030.659386812255, 17439.82560174401, 17447.563810904703, 17458.56353591161, 5131.281620573122, 5366.329208848894, 5447.237386765856, 5451.100568406208, 5455.945440545584, 3955.564887862333, 5366.382865970405, 5601.635893666919, 5993.760249590011, 6045.214122164112, 5917.260342457193, 5959.1359252908305, 5964.19483369746, 6002.099685047234, 6006.339302676702, 5723.742431590567, 6030.306514750794, 6034.788782392639, 6040.697965101749, 6041.6375017499095, 3620.25784714133, 5141.5886729061585, 5331.306930099101, 5361.142217245222, 5373.167159090308, 20943.05756240973, 20975.0, 21258.574828503344, 22307.0, 22442.77557224423, 2085.895705214733, 2114.1860383752214, 2219.5006123622215, 2260.536589999046, 2340.075670110297, 12749.936250318782, 13122.0, 13279.336033198399, 13312.933435332858, 13481.0, 1832.5594316783793, 1904.8952307623076, 1909.9618007639908, 1943.3004118517322, 1982.544014876572, 65332.346676533576, 66938.0, 67086.9999999995, 68026.65986670036, 69489.0, 10044.849327260097, 10047.949760251298, 10352.792944141074, 10468.63359782404, 10675.786484270271, 13890.166590004632, 13919.703248963808, 13973.0, 13993.440262389391, 14032.649183770283, 7400.555966642019, 7847.489913155627, 7872.055353357634, 7910.683572657144, 8017.278444939983, 7639.159692433828, 7665.118511371152, 7738.303552680286, 7793.688252469951, 7800.531968081933, 6200.100985357189, 6291.874162516724, 6304.653244071528, 6317.936820631735, 6319.58922670025, 1716.6223430845193, 1786.580153663888, 1795.3267524678245, 1798.7678440268458, 1798.9132606176772, 922.064104933493, 982.1553464020936, 1002.3434650304063, 1031.6492392586556, 1045.7856139491387, 17184.484465466056, 17829.7325540117, 18140.63718725618, 18182.090895455174, 18400.539986500444, 895.6788736613443, 924.0, 940.1726480696943, 940.9059094090536, 1011.2870426349554, 9953.502324883726, 10392.37645741258, 10412.5834966602, 10431.68704938853, 10446.582136714598, 370744.0, 371017.0, 388694.0, 389692.0, 390896.0, 76126.61936690281, 76128.61935690398, 77896.0, 79665.0, 79872.0, 1034.5861655337926, 1040.8178568750438, 1089.8256278995323, 1107.645553422897, 1107.6566264458045, 15672.294746736196, 15936.362545498514, 15955.361785528448, 16103.919480402992, 16157.4344897928, 34066.0, 34284.14289642779, 34459.82770086134, 34693.30613387668, 35387.46918796271, 46714.0, 47545.28682069702, 47573.76213118912, 48319.20169579673, 48449.27326090182, 10194.490275486345, 11426.314421134759, 11449.885501144881, 11662.416879156179, 11704.882951170379, 12849.0, 12922.935385323013, 13174.802377964146, 13244.933775331061, 13622.38699258516, 10771.676849694522, 11124.443777810915, 11473.541058357572, 11726.765464690829, 11739.471723772622, 11260.549578017115, 11505.712357191138, 11644.2431241969, 11746.236494627821, 11773.0, 11273.478080459034, 11392.601258955896, 11882.940585297018, 11994.64016079519, 12089.335086570323, 10715.678529644123, 10756.408397537898, 10827.296225745302, 10874.891251087703, 11201.551937922392, 11412.201145919706, 11439.885601143882, 11699.590514332298, 11869.287842729464, 11958.342291173722], "unit": "score", "name": "jquery.html", "value": 8958.810098748078}, {"lowerIsBetter": false, "replicates": [1313.678148853531, 1443.1990245413797, 1456.7887656289836, 1625.2605064695565, 1806.1420825108075, 7217.7112915483385, 7379.778606641796, 7397.408207343399, 7423.072115985502, 7425.814354641137, 7669.309762121408, 7846.72536461224, 7848.0, 7853.253940875622, 7865.134835168127, 2008.658528050235, 2056.5578400643935, 2254.785795349447, 2337.4273303040736, 2361.9055237790467, 2303.1133013789727, 2307.0195167054017, 2308.376738280663, 2313.7223533175957, 2314.0743702519044, 2261.683364328995, 2264.2527965771337, 2337.1002164166835, 2340.1458467659268, 2371.1108334374608, 2302.7582103879017, 2336.894839732208, 2337.5792357375667, 2344.085806535444, 2348.2602980061397, 2288.084766093559, 2302.850314729554, 2304.9078036878504, 2308.90764369425, 2311.4336987438187, 7929.841403171962, 8007.67969281228, 8022.839543209161, 8033.839323213561, 8040.276375126266, 4790.401199850019, 4927.088488629579, 4963.8262660806695, 4965.354503914504, 4965.577925876305, 3078.9993252193126, 3098.612673415823, 3120.7659425542947, 3138.73320767735, 3236.514522821572, 950.097407462913, 971.0386717150042, 973.2214228617078, 975.5219942228327, 1009.1724785675749, 11162.832557511643, 11221.607243746512, 11227.045701115416, 11246.55013799447, 11257.943710281395, 4304.3543468479975, 4453.910921781546, 4492.191405547033, 4509.368688383629, 4521.660875434355, 9441.15029647335, 9464.574094165779, 9468.668596599086, 9471.621135154517, 9524.047595240421, 4955.727434991038, 4988.775505102279, 4994.9750251248515, 5004.774785134678, 5006.64953453262, 3912.158885839558, 4321.2005778931, 4403.691741578123, 4406.845760398371, 4461.955380446219, 3720.8883733488037, 3795.6773674237447, 3798.9430158547643, 3805.219929914361, 3854.036490877281, 1218.6831423829867, 1218.9634310970685, 1224.3266203587991, 1233.9197952133084, 1254.4166962362544, 1246.931418771958, 1256.2525297448003, 1269.4097244781037, 1341.7651910915552, 1345.0114166087917, 7456.142543607554, 7468.103827540621, 7484.887726684104, 7497.925020749832, 7575.621218939141, 476.3355119608127, 483.7484508055791, 486.0352200881248, 487.06240487062973, 489.81631888041983, 5495.807646732345, 5516.3380394352935, 5525.4474552545225, 5558.166275058693, 5564.66612003273, 9337.299702522338, 9617.326787124974, 9760.023997600325, 9883.505824708736, 9921.900780992242, 9597.712068637951, 9647.517624118766, 9654.227661787181, 9734.659286924923, 9802.166815820736, 7353.926460735431, 7522.3605993491165, 7562.924370756442, 7596.886046709304, 7601.315881570575, 7225.0, 7233.168185658506, 7263.237360077327, 7304.96347518259, 7312.1591017033725, 8551.102134275812, 8651.826963460822, 8708.085651006553, 8709.346798989975, 8719.91280087191, 8614.483131012159, 8735.126487351214, 8880.378373513791, 8918.24194943437, 9070.092990700878, 6245.6252624842655, 6613.0, 6878.105846239957, 7078.787636370917, 7156.606386648576, 7533.322001019935, 7541.2458754124145, 7543.698252070075, 7548.320651141204, 7559.357454616199, 6711.798646040626, 6837.829054273683, 6914.101166848278, 6999.720011199699, 7108.715651374094, 6831.9658401707675, 6887.93112068893, 6926.619035953071, 7027.191872934473, 7041.295870412918, 7142.500024998408, 7166.247544007804, 7170.928290717235, 7267.418606511361, 7294.416446684359, 6433.356664333529, 6444.7744328948265, 6461.2892581816905, 6466.094746735367, 6503.772367967098, 6360.49116070704, 6640.667966601554, 6642.933570664231, 6657.40083392497, 6703.162104736908], "unit": "score", "name": "mootools.html", "value": 4465.306197135869}, {"lowerIsBetter": false, "replicates": [338.80349397349534, 340.419584608243, 344.6432941905128, 348.904051385869, 350.8842082112901, 5904.704764761761, 5908.940910590898, 5926.111083337496, 5953.047512398017, 5973.432523910222, 5906.173135760997, 5912.940870591293, 5913.852153696149, 5915.704214789265, 5934.228550288467, 4366.868993930179, 4452.666050046243, 4546.045330480603, 4553.043860789238, 4615.699979501338, 4580.702254353473, 4585.518520555327, 4597.977010114945, 4612.3542704021465, 4614.769261536927, 4351.434313539251, 4547.613452856494, 4553.134904368176, 4563.178627846986, 4568.885777855547, 4423.447069116361, 4496.730196188223, 4512.075024619945, 4560.612347950429, 4567.566081222279, 4012.0972781124306, 4018.2365350583586, 4021.537523184842, 4028.7179897407195, 4030.8186131624147, 5633.774649014075, 5639.464250896158, 5642.576806739511, 5649.0396632572565, 5663.405342439067, 5347.331583552056, 5347.652402593858, 5350.250964864922, 5351.304330437058, 5355.732213389354, 6285.2771931228035, 6304.7793327233785, 6330.905036424458, 6331.303556608769, 6335.176427064452, 4390.956090439086, 4493.5506449355125, 4508.819647214107, 4514.706544074625, 4515.661325400608, 6537.248216455074, 6569.770058047993, 6570.178727659043, 6578.407943285079, 6583.967080164616, 4612.492625811158, 4613.653975951817, 4617.353570500132, 4620.0, 4632.490426053131, 4674.485806561275, 4675.438947326343, 4677.0, 4680.297955306663, 4682.344471773954, 5332.9733351333, 5341.866453338697, 5347.0909945309395, 5348.786048558014, 5356.1697936819855, 6212.4408803207925, 6358.300586935434, 6361.141245931833, 6377.904331435032, 6382.680865956683, 1625.3986025170761, 1630.7879975603096, 1646.0864220357578, 1651.7604947282578, 1655.213773457598, 1052.3422860712055, 1079.9784004320027, 1092.0390056750168, 1121.5738019552518, 1146.827975803636, 5930.970345148246, 5941.940580594225, 5948.315943666534, 5948.613340132964, 5967.940320596826, 6424.453921416639, 6450.0647406125845, 6455.483561315177, 6463.095166676669, 6464.25661048976, 5916.0, 5961.076033214858, 5986.102084687332, 5988.101784732238, 5992.550558708114, 3430.3139372125675, 3471.8437670304897, 3473.340065387619, 3476.5480487536456, 3477.4957631143343, 6511.544191906521, 6720.32796720324, 6732.360425759545, 6774.796756097325, 6827.863442731217, 6568.211814582281, 6580.144581204413, 6591.901121483182, 6596.142501474777, 6601.009848522664, 6733.7643182489355, 6734.259231484532, 6746.730130794811, 6752.358525940126, 6753.425958793558, 6414.550981431255, 6415.903761443676, 6425.9036114457385, 6434.324395938359, 6434.967825160844, 5821.243238378984, 6121.265448146251, 6319.747210111544, 6380.298167201511, 6395.456386207225, 6631.966840165768, 6803.319668033157, 6860.211075726155, 6869.003994420881, 6880.862382752217, 4628.67599268048, 4630.212863813227, 4631.305304204397, 4649.465311489222, 4653.650976176733, 6528.445082168069, 6539.280679125197, 6540.345965403421, 6549.574277671936, 6575.704093315908, 6344.080108384351, 6348.841278967878, 6357.523185760994, 6359.0, 6360.459360954371, 6182.6599537025895, 6347.460465860454, 6374.968125159345, 6405.19935008124, 6430.582012169194, 6210.068489726577, 6277.466415354564, 6279.466245369012, 6282.842928926813, 6288.213973253343, 6386.776462823779, 6390.840228994312, 6463.935360646334, 6470.547061705635, 6476.190476190476, 5984.670843103671, 6116.969415153074, 6263.279722831932, 6274.058891166362, 6277.089821975879], "unit": "score", "name": "prototype.html", "value": 4785.7290358453565}, {"lowerIsBetter": false, "replicates": [700.8318003679116, 782.3193821375404, 801.6232370785729, 821.6384790692099, 828.449081360895, 13735.175889446627, 13955.906614007903, 13957.930210348959, 14024.01831871768, 14040.859591404096, 14653.706925861476, 14944.40222391103, 14962.850371496283, 14975.625609359771, 14983.92508037461, 696.6377483708469, 830.0661755525049, 839.86562150056, 844.6536919862857, 845.5687599324358, 843.9198276163754, 847.4491580472711, 847.6990668312752, 847.7541512961234, 850.1201256699318, 896.5024411451642, 901.3555307954811, 902.4900930974012, 902.5351943748974, 902.7246689759621, 720.125048066599, 870.8954925408959, 889.4174315823146, 890.4612709310838, 895.9731208063736, 653.8986457099157, 656.8193746719691, 658.410722403451, 659.9439047680953, 662.8243515468405, 13886.0, 13976.231307278096, 13983.720325593533, 14020.088694234842, 14054.648633784238, 12577.496900123984, 12715.427805748763, 12967.157134786208, 13002.934985325108, 13268.86731132686, 10908.454577271184, 10953.671389858317, 10973.23187376884, 11028.558857645685, 11063.778724425467, 3531.682148606638, 3541.7009130714005, 3701.056230661191, 3726.888193354204, 3736.0, 51050.23424648633, 51174.0, 51524.0, 51578.7421062896, 51687.22469163003, 10082.69751907444, 10290.3825770454, 10379.688609341732, 10448.798388185303, 10913.672589822318, 18863.811361886204, 18887.433376998713, 18892.33876814305, 18900.527486812938, 18917.0, 7844.097928738268, 8024.638891249908, 8043.075046369625, 8066.15305392937, 8089.716859909875, 4387.078713470143, 4559.863204103882, 4594.0, 4633.6524760642415, 4780.402449693788, 3127.796693214934, 3135.8902438415003, 3147.984260078685, 3151.936961260762, 3155.6213254409618, 497.2193655960108, 557.5316733943507, 584.1704779213527, 588.7027051339046, 589.1192666962833, 539.970301633406, 640.50040968045, 682.8728510689267, 689.9137607799025, 690.0718533572337, 7735.690572377154, 8084.1107478177355, 8392.580370981426, 8423.284020858173, 8629.784255393666, 608.2245137449787, 643.2955913274957, 645.3901063495045, 666.8199586111723, 672.5729161982176, 3884.320243957296, 3899.5905429930017, 3915.647591716759, 3920.6863450923856, 3980.5024371953505, 58104.4189558099, 58850.411495885346, 59312.0, 59375.0, 59527.702361487914, 51954.0, 52469.0, 52681.473185267656, 53126.46873531293, 53226.0, 46716.76641616838, 47366.0, 47370.5262947373, 47637.28544071842, 48395.5160448398, 7826.7651970440975, 7830.4518683691595, 7923.564203968837, 7986.0, 8067.798305042421, 34854.0, 35623.64376356203, 36003.63996360003, 36581.63418365889, 36936.26127477489, 41784.79107604564, 41862.581374185866, 44015.11969760651, 45547.77226113848, 46086.0, 10906.291091079054, 10910.290831095954, 10995.120390368591, 11163.609273675382, 11488.597899073493, 10358.792824143626, 10510.579576816841, 10856.45717714127, 11733.706657333634, 11749.941250293694, 10737.946310268399, 10956.945215273872, 11217.439128043728, 11227.943860280646, 11596.594119205787, 10954.561817527529, 11278.0, 11512.82730759056, 11530.76938461243, 11541.653750387502, 10197.337173083726, 10367.94816025915, 10474.947625261824, 10939.343639381663, 11131.220814543229, 8956.507392093497, 8958.328125390492, 9246.768830779016, 9401.482918439278, 9594.18449431806, 7647.235276472308, 8076.959615201887, 8627.95686021566, 9022.233110185707, 9769.43689009755], "unit": "score", "name": "yui.html", "value": 6372.88591878348}], "name": "dromaeo_css", "value": 6935.835342958056}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 112.0, 107.0, 111.0, 112.0, 112.0, 100.0, 111.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 109.6}, {"lowerIsBetter": true, "replicates": [152.0, 127.0, 155.0, 175.0, 127.0, 160.0, 158.0, 129.0, 176.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 148.6}, {"lowerIsBetter": true, "replicates": [161.0, 163.0, 161.0, 161.0, 160.0, 162.0, 163.0, 162.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.5}, {"lowerIsBetter": true, "replicates": [75.0, 76.0, 104.0, 94.0, 76.0, 72.0, 74.0, 114.0, 94.0, 75.0], "unit": "score", "name": "audio-fft", "value": 85.4}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 140.0, 93.0, 92.0, 93.0, 146.0, 93.0, 94.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 107.7}, {"lowerIsBetter": true, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.7}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 145.0, 144.0, 146.0, 146.0, 145.0, 145.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.3}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [59.0, 59.0, 59.0, 58.0, 60.0, 60.0, 60.0, 68.0, 58.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 59.9}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 67.0, 67.0, 68.0, 68.0, 66.0, 68.0, 67.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.2}, {"lowerIsBetter": true, "replicates": [91.0, 83.0, 83.0, 84.0, 83.0, 91.0, 83.0, 83.0, 83.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.8}, {"lowerIsBetter": true, "replicates": [120.0, 116.0, 122.0, 113.0, 114.0, 114.0, 117.0, 117.0, 119.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.8}, {"lowerIsBetter": true, "replicates": [168.0, 140.0, 155.0, 154.0, 155.0, 140.0, 149.0, 156.0, 141.0, 150.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.8}, {"lowerIsBetter": true, "replicates": [70.0, 68.0, 69.0, 70.0, 68.0, 74.0, 70.0, 69.0, 69.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.5}], "name": "kraken", "value": 1519.8000000000002}]} 17:29:50 INFO - Return code: 0 17:29:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 17:29:50 INFO - # TBPL SUCCESS # 17:29:50 INFO - Running post-action listener: _resource_record_post_action 17:29:50 INFO - Running post-run listener: _resource_record_post_run 17:29:51 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 471040; Write bytes: 534880256; Read time: 104; Write time: 853444 17:29:51 INFO - install - Wall time: 16s; CPU: 17.0%; Read bytes: 0; Write bytes: 240656384; Read time: 0; Write time: 554188 17:29:51 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 471040; Write bytes: 292675584; Read time: 104; Write time: 299248 17:29:51 INFO - Running post-run listener: _upload_blobber_files 17:29:51 INFO - Blob upload gear active. 17:29:51 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 17:29:51 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:29:51 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', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 17:29:51 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 Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 17:29:52 INFO - (blobuploader) - INFO - Open directory for files ... 17:29:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:29:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:29:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:29:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:29:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:29:52 INFO - (blobuploader) - INFO - Done attempting. 17:29:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 17:29:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:29:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:29:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:29:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:29:53 INFO - (blobuploader) - INFO - Done attempting. 17:29:53 INFO - (blobuploader) - INFO - Iteration through files over. 17:29:53 INFO - Return code: 0 17:29:53 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 17:29:53 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 17:29:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/694f385c6d57ffc7c7eea44902146501f47d08bfbe96e4d906917d4eeea9d4d0cf87921ddf55a7b13866d7be4e3eef63222af101136af0fef61d70383e24f33e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5f22f9a668fbf72324c010a82a87df15534d9918afb36f64497ba66d27444e8abb5fdee9f3ffaff005036414335987976b996e4d2967acb7b7be9b9df7a80070"} 17:29:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 17:29:53 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 17:29:53 INFO - Contents: 17:29:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/694f385c6d57ffc7c7eea44902146501f47d08bfbe96e4d906917d4eeea9d4d0cf87921ddf55a7b13866d7be4e3eef63222af101136af0fef61d70383e24f33e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5f22f9a668fbf72324c010a82a87df15534d9918afb36f64497ba66d27444e8abb5fdee9f3ffaff005036414335987976b996e4d2967acb7b7be9b9df7a80070"} 17:29:53 INFO - Running post-run listener: copy_logs_to_upload_dir 17:29:53 INFO - Copying logs to upload dir... 17:29:53 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 17:29:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.893968 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-03-04 17:29:53.709251) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-04 17:29:53.712733) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1457140154.704486-282231353 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/694f385c6d57ffc7c7eea44902146501f47d08bfbe96e4d906917d4eeea9d4d0cf87921ddf55a7b13866d7be4e3eef63222af101136af0fef61d70383e24f33e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5f22f9a668fbf72324c010a82a87df15534d9918afb36f64497ba66d27444e8abb5fdee9f3ffaff005036414335987976b996e4d2967acb7b7be9b9df7a80070"} build_url:https://queue.taskcluster.net/v1/task/G98YxQUIRU-85VqCk2Z4qg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011400 build_url: 'https://queue.taskcluster.net/v1/task/G98YxQUIRU-85VqCk2Z4qg/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/Fx-Team/sha512/694f385c6d57ffc7c7eea44902146501f47d08bfbe96e4d906917d4eeea9d4d0cf87921ddf55a7b13866d7be4e3eef63222af101136af0fef61d70383e24f33e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5f22f9a668fbf72324c010a82a87df15534d9918afb36f64497ba66d27444e8abb5fdee9f3ffaff005036414335987976b996e4d2967acb7b7be9b9df7a80070"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-04 17:29:53.738289) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 17:29:53.738650) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1457140154.704486-282231353 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004473 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 17:29:53.820640) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-04 17:29:53.821012) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-04 17:29:53.821376) ========= ========= Total master_lag: 0.23 =========