builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-044 starttime: 1460052433.53 results: success (0) buildid: 20160407083318 builduid: db2c412e07b14a189532fd2f6118fb7b revision: f5d7c57cdfd7574361db3a1b555db546c4ccaf22 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-07 11:07:13.529340) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-07 11:07:13.529740) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-07 11:07:13.530015) ========= 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=574dc5aafe09851ec43d388c000001b6-1460052184.843169-905759111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006299 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-07 11:07:13.552963) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-07 11:07:13.553231) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-07 11:07:13.566296) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 11:07:13.566559) ========= 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=574dc5aafe09851ec43d388c000001b6-1460052184.843169-905759111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004549 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 11:07:13.618356) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-07 11:07:13.618618) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-07 11:07:13.619001) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 11:07:13.619272) ========= 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=574dc5aafe09851ec43d388c000001b6-1460052184.843169-905759111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-07 11:07:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 47.0M=0s 2016-04-07 11:07:14 (47.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.092660 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 11:07:13.727655) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 11:07:13.727926) ========= 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=574dc5aafe09851ec43d388c000001b6-1460052184.843169-905759111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020497 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 11:07:13.780327) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 11:07:13.780651) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f5d7c57cdfd7574361db3a1b555db546c4ccaf22 --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 f5d7c57cdfd7574361db3a1b555db546c4ccaf22 --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=574dc5aafe09851ec43d388c000001b6-1460052184.843169-905759111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-07 11:07:14,275 truncating revision to first 12 chars 2016-04-07 11:07:14,275 Setting DEBUG logging. 2016-04-07 11:07:14,275 attempt 1/10 2016-04-07 11:07:14,275 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f5d7c57cdfd7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-07 11:07:14,591 unpacking tar archive at: fx-team-f5d7c57cdfd7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.576111 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 11:07:14.368996) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-07 11:07:14.369306) ========= echo f5d7c57cdfd7574361db3a1b555db546c4ccaf22 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'f5d7c57cdfd7574361db3a1b555db546c4ccaf22'] 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=574dc5aafe09851ec43d388c000001b6-1460052184.843169-905759111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False f5d7c57cdfd7574361db3a1b555db546c4ccaf22 program finished with exit code 0 elapsedTime=0.004956 script_repo_revision: 'f5d7c57cdfd7574361db3a1b555db546c4ccaf22' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-07 11:07:14.420095) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-07 11:07:14.420387) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-07 11:07:14.430158) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-04-07 11:07:14.430427) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=574dc5aafe09851ec43d388c000001b6-1460052184.843169-905759111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:07:15 INFO - MultiFileLogger online at 20160407 11:07:15 in /builds/slave/test-pgo 11:07:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:07:15 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 11:07:15 INFO - {'append_to_log': False, 11:07:15 INFO - 'base_work_dir': '/builds/slave/test-pgo', 11:07:15 INFO - 'blob_upload_branch': 'Fx-Team', 11:07:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 11:07:15 INFO - 'branch': 'Fx-Team', 11:07:15 INFO - 'buildbot_json_path': 'buildprops.json', 11:07:15 INFO - 'config_files': ('talos/linux_config.py',), 11:07:15 INFO - 'default_actions': ('clobber', 11:07:15 INFO - 'read-buildbot-config', 11:07:15 INFO - 'download-and-extract', 11:07:15 INFO - 'populate-webroot', 11:07:15 INFO - 'create-virtualenv', 11:07:15 INFO - 'install', 11:07:15 INFO - 'run-tests'), 11:07:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:07:15 INFO - 'download_minidump_stackwalk': True, 11:07:15 INFO - 'download_symbols': 'ondemand', 11:07:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:07:15 INFO - 'tooltool.py': '/tools/tooltool.py', 11:07:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:07:15 INFO - '/tools/misc-python/virtualenv.py')}, 11:07:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:07:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:07:15 INFO - 'installer_path': 'installer.exe', 11:07:15 INFO - 'log_level': 'info', 11:07:15 INFO - 'log_name': 'talos', 11:07:15 INFO - 'log_to_console': True, 11:07:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:07:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:07:15 INFO - 'opt_config_files': (), 11:07:15 INFO - 'pip_index': False, 11:07:15 INFO - 'sps_profile': False, 11:07:15 INFO - 'sps_profile_interval': 0, 11:07:15 INFO - 'suite': 'dromaeojs-e10s', 11:07:15 INFO - 'system_bits': '32', 11:07:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:07:15 INFO - 'title': 'talos-linux64-ix-044', 11:07:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:07:15 INFO - 'use_talos_json': True, 11:07:15 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 11:07:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:07:15 INFO - 'work_dir': 'build'} 11:07:15 INFO - ##### 11:07:15 INFO - ##### Running clobber step. 11:07:15 INFO - ##### 11:07:15 INFO - Running pre-action listener: _resource_record_pre_action 11:07:15 INFO - Running main action method: clobber 11:07:15 INFO - rmtree: /builds/slave/test-pgo/build 11:07:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 11:07:15 INFO - Running post-action listener: _resource_record_post_action 11:07:15 INFO - ##### 11:07:15 INFO - ##### Running read-buildbot-config step. 11:07:15 INFO - ##### 11:07:15 INFO - Running pre-action listener: _resource_record_pre_action 11:07:15 INFO - Running main action method: read_buildbot_config 11:07:15 INFO - Using buildbot properties: 11:07:15 INFO - { 11:07:15 INFO - "project": "", 11:07:15 INFO - "product": "firefox", 11:07:15 INFO - "script_repo_revision": "production", 11:07:15 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 11:07:15 INFO - "repository": "", 11:07:15 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 11:07:15 INFO - "buildid": "20160407083318", 11:07:15 INFO - "pgo_build": "True", 11:07:15 INFO - "basedir": "/builds/slave/test-pgo", 11:07:15 INFO - "buildnumber": 622, 11:07:15 INFO - "slavename": "talos-linux64-ix-044", 11:07:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:07:15 INFO - "platform": "ubuntu64_hw", 11:07:15 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:07:15 INFO - "branch": "fx-team", 11:07:15 INFO - "repo_path": "integration/fx-team", 11:07:15 INFO - "revision": "f5d7c57cdfd7574361db3a1b555db546c4ccaf22", 11:07:15 INFO - "stage_platform": "linux64-pgo", 11:07:15 INFO - "builduid": "db2c412e07b14a189532fd2f6118fb7b", 11:07:15 INFO - "slavebuilddir": "test" 11:07:15 INFO - } 11:07:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ezcu_2ZaTbuOlhEKrw47fQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 11:07:15 INFO - Running post-action listener: _resource_record_post_action 11:07:15 INFO - ##### 11:07:15 INFO - ##### Running download-and-extract step. 11:07:15 INFO - ##### 11:07:15 INFO - Running pre-action listener: _resource_record_pre_action 11:07:15 INFO - Running main action method: download_and_extract 11:07:15 INFO - mkdir: /builds/slave/test-pgo/build/tests 11:07: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')]} 11:07:15 INFO - https://queue.taskcluster.net/v1/task/Ezcu_2ZaTbuOlhEKrw47fQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:07:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ezcu_2ZaTbuOlhEKrw47fQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:07:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ezcu_2ZaTbuOlhEKrw47fQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:07:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ezcu_2ZaTbuOlhEKrw47fQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:07:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ezcu_2ZaTbuOlhEKrw47fQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:07:17 INFO - Downloaded 1361 bytes. 11:07:17 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:07:17 INFO - Using the following test package requirements: 11:07:17 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 11:07:17 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:07:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:07:17 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:07:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:07:17 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:07:17 INFO - u'jsshell-linux-x86_64.zip'], 11:07:17 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:07:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:07:17 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 11:07:17 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:07:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:07:17 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:07:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:07:17 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:07:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:07:17 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:07:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:07:17 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:07:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:17 INFO - https://queue.taskcluster.net/v1/task/Ezcu_2ZaTbuOlhEKrw47fQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:07:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ezcu_2ZaTbuOlhEKrw47fQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:07:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ezcu_2ZaTbuOlhEKrw47fQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:07:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ezcu_2ZaTbuOlhEKrw47fQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:07:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ezcu_2ZaTbuOlhEKrw47fQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:07:19 INFO - Downloaded 23714867 bytes. 11:07:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 11:07:19 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 11:07:20 INFO - Return code: 0 11:07:20 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:07:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:20 INFO - https://queue.taskcluster.net/v1/task/Ezcu_2ZaTbuOlhEKrw47fQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:07:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ezcu_2ZaTbuOlhEKrw47fQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:07:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ezcu_2ZaTbuOlhEKrw47fQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:07:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ezcu_2ZaTbuOlhEKrw47fQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:07:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ezcu_2ZaTbuOlhEKrw47fQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:07:27 INFO - Downloaded 23714867 bytes. 11:07:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 11:07:27 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 11:07:28 INFO - Return code: 0 11:07:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:28 INFO - https://queue.taskcluster.net/v1/task/Ezcu_2ZaTbuOlhEKrw47fQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:07:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ezcu_2ZaTbuOlhEKrw47fQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 11:07:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ezcu_2ZaTbuOlhEKrw47fQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 11:07:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ezcu_2ZaTbuOlhEKrw47fQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 11:07:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ezcu_2ZaTbuOlhEKrw47fQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:07:39 INFO - Downloaded 10847693 bytes. 11:07:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 11:07:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 11:07:39 INFO - Return code: 0 11:07:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:39 INFO - https://queue.taskcluster.net/v1/task/Ezcu_2ZaTbuOlhEKrw47fQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:07:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ezcu_2ZaTbuOlhEKrw47fQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:07:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ezcu_2ZaTbuOlhEKrw47fQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:07:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ezcu_2ZaTbuOlhEKrw47fQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:07:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ezcu_2ZaTbuOlhEKrw47fQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:07:42 INFO - Downloaded 57898869 bytes. 11:07:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ezcu_2ZaTbuOlhEKrw47fQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:07:42 INFO - mkdir: /builds/slave/test-pgo/properties 11:07:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 11:07:42 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 11:07:42 INFO - Contents: 11:07:42 INFO - build_url:https://queue.taskcluster.net/v1/task/Ezcu_2ZaTbuOlhEKrw47fQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:07:43 INFO - Running post-action listener: _resource_record_post_action 11:07:43 INFO - Running post-action listener: set_extra_try_arguments 11:07:43 INFO - ##### 11:07:43 INFO - ##### Running populate-webroot step. 11:07:43 INFO - ##### 11:07:43 INFO - Running pre-action listener: _resource_record_pre_action 11:07:43 INFO - Running main action method: populate_webroot 11:07:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:07:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:07:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:07:43 INFO - '--tppagecycles', 11:07:43 INFO - '7'], 11:07:43 INFO - 'tests': ['tsvgm']}}, 11:07:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:07:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:07:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:07:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:07:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:07:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:07:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:43 INFO - 'talos_options': ['--disable-e10s'], 11:07:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:07:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:07:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:43 INFO - 'talos_options': ['--disable-e10s'], 11:07:43 INFO - 'tests': ['damp', 'tps']}, 11:07:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:43 INFO - 'tests': ['damp', 'tps']}, 11:07:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:07:43 INFO - 'tests': ['dromaeo_dom']}, 11:07:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:07:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:07:43 INFO - 'tests': ['a11yr', 11:07:43 INFO - 'ts_paint', 11:07:43 INFO - 'tpaint', 11:07:43 INFO - 'sessionrestore', 11:07:43 INFO - 'sessionrestore_no_auto_restore', 11:07:43 INFO - 'tabpaint']}, 11:07:43 INFO - 'other-e10s': {'tests': ['a11yr', 11:07:43 INFO - 'ts_paint', 11:07:43 INFO - 'tpaint', 11:07:43 INFO - 'sessionrestore', 11:07:43 INFO - 'sessionrestore_no_auto_restore', 11:07:43 INFO - 'tabpaint']}, 11:07:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:07:43 INFO - 'ts_paint', 11:07:43 INFO - 'tpaint', 11:07:43 INFO - 'sessionrestore', 11:07:43 INFO - 'sessionrestore_no_auto_restore', 11:07:43 INFO - 'tabpaint']}, 11:07:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:07:43 INFO - 'ts_paint', 11:07:43 INFO - 'tpaint', 11:07:43 INFO - 'sessionrestore', 11:07:43 INFO - 'sessionrestore_no_auto_restore', 11:07:43 INFO - 'tabpaint']}, 11:07:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:07:43 INFO - 'tests': ['a11yr', 11:07:43 INFO - 'ts_paint', 11:07:43 INFO - 'tpaint', 11:07:43 INFO - 'sessionrestore', 11:07:43 INFO - 'sessionrestore_no_auto_restore', 11:07:43 INFO - 'tabpaint']}, 11:07:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:07:43 INFO - 'tests': ['a11yr', 11:07:43 INFO - 'ts_paint', 11:07:43 INFO - 'tpaint', 11:07:43 INFO - 'sessionrestore', 11:07:43 INFO - 'sessionrestore_no_auto_restore', 11:07:43 INFO - 'tabpaint']}, 11:07:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:07:43 INFO - 'tests': ['tsvgx', 11:07:43 INFO - 'tsvgr_opacity', 11:07:43 INFO - 'tart', 11:07:43 INFO - 'tscrollx', 11:07:43 INFO - 'cart']}, 11:07:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:07:43 INFO - 'tsvgr_opacity', 11:07:43 INFO - 'tart', 11:07:43 INFO - 'tscrollx', 11:07:43 INFO - 'cart']}, 11:07:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:43 INFO - 'talos_options': ['--disable-e10s'], 11:07:43 INFO - 'tests': ['tp5o']}, 11:07:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:43 INFO - 'tests': ['tp5o']}, 11:07:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:43 INFO - 'talos_options': ['--disable-e10s', 11:07:43 INFO - '--xperf_path', 11:07:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:07:43 INFO - 'tests': ['tp5n']}, 11:07:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:43 INFO - 'talos_options': ['--xperf_path', 11:07:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:07:43 INFO - 'tests': ['tp5n']}}, 11:07:43 INFO - 'talos.zip': {'path': '', 11:07:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:07:43 INFO - Running post-action listener: _resource_record_post_action 11:07:43 INFO - ##### 11:07:43 INFO - ##### Running create-virtualenv step. 11:07:43 INFO - ##### 11:07:43 INFO - Running pre-action listener: _resource_record_pre_action 11:07:43 INFO - Running main action method: create_virtualenv 11:07:43 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 11:07:43 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 11:07:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 11:07:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:07:43 INFO - Using real prefix '/usr' 11:07:43 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 11:07:44 INFO - Installing distribute.............................................................................................................................................................................................done. 11:07:46 INFO - Installing pip.................done. 11:07:46 INFO - Return code: 0 11:07:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 11:07: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')]} 11:07:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07: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')]} 11:07:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:46 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 0x7f44d9caaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29318d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c08b0>, '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 0x29c17b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c1c60>, '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': '574dc5aafe09851ec43d388c000001b6-1460052184.843169-905759111', '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 11:07:46 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 11:07:46 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 11:07:46 INFO - Using env: {'DISPLAY': ':0', 11:07:46 INFO - 'HOME': '/home/cltbld', 11:07:46 INFO - 'LANG': 'en_US.UTF-8', 11:07:46 INFO - 'LANGUAGE': 'en_US:en', 11:07:46 INFO - 'LOGNAME': 'cltbld', 11:07:46 INFO - 'MAIL': '/var/mail/cltbld', 11:07:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:46 INFO - 'MOZ_NO_REMOTE': '1', 11:07:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:46 INFO - 'NO_EM_RESTART': '1', 11:07:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:07:46 INFO - 'PWD': '/builds/slave/test-pgo', 11:07:46 INFO - 'SHELL': '/bin/bash', 11:07:46 INFO - 'SHLVL': '1', 11:07:46 INFO - 'TERM': 'linux', 11:07:46 INFO - 'TMOUT': '86400', 11:07:46 INFO - 'USER': 'cltbld', 11:07:46 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1460052184.843169-905759111', 11:07:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:46 INFO - '_': '/tools/buildbot/bin/python'} 11:07:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:46 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 11:07:46 INFO - Cleaning up... 11:07:46 INFO - Return code: 0 11:07:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 11:07: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')]} 11:07:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07: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')]} 11:07:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:46 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 0x7f44d9caaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29318d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c08b0>, '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 0x29c17b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c1c60>, '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': '574dc5aafe09851ec43d388c000001b6-1460052184.843169-905759111', '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 11:07:46 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 11:07:46 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 11:07:46 INFO - Using env: {'DISPLAY': ':0', 11:07:46 INFO - 'HOME': '/home/cltbld', 11:07:46 INFO - 'LANG': 'en_US.UTF-8', 11:07:46 INFO - 'LANGUAGE': 'en_US:en', 11:07:46 INFO - 'LOGNAME': 'cltbld', 11:07:46 INFO - 'MAIL': '/var/mail/cltbld', 11:07:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:46 INFO - 'MOZ_NO_REMOTE': '1', 11:07:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:46 INFO - 'NO_EM_RESTART': '1', 11:07:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:07:46 INFO - 'PWD': '/builds/slave/test-pgo', 11:07:46 INFO - 'SHELL': '/bin/bash', 11:07:46 INFO - 'SHLVL': '1', 11:07:46 INFO - 'TERM': 'linux', 11:07:46 INFO - 'TMOUT': '86400', 11:07:46 INFO - 'USER': 'cltbld', 11:07:46 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1460052184.843169-905759111', 11:07:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:46 INFO - '_': '/tools/buildbot/bin/python'} 11:07:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:46 INFO - Downloading/unpacking psutil>=0.7.1 11:07:46 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 11:07:46 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 11:07:46 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 11:07:46 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 11:07:46 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 11:07:46 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 11:07:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 11:07:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:07:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:07:48 INFO - Installing collected packages: psutil 11:07:48 INFO - Running setup.py install for psutil 11:07:48 INFO - building 'psutil._psutil_linux' extension 11:07:48 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 11:07:48 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 11:07:48 INFO - building 'psutil._psutil_posix' extension 11:07:48 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 11:07:48 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 11:07:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:07:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:07:48 INFO - Successfully installed psutil 11:07:48 INFO - Cleaning up... 11:07:49 INFO - Return code: 0 11:07:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 11:07: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')]} 11:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07: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')]} 11:07:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f44d9caaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29318d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c08b0>, '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 0x29c17b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c1c60>, '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': '574dc5aafe09851ec43d388c000001b6-1460052184.843169-905759111', '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 11:07:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 11:07:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 11:07:49 INFO - Using env: {'DISPLAY': ':0', 11:07:49 INFO - 'HOME': '/home/cltbld', 11:07:49 INFO - 'LANG': 'en_US.UTF-8', 11:07:49 INFO - 'LANGUAGE': 'en_US:en', 11:07:49 INFO - 'LOGNAME': 'cltbld', 11:07:49 INFO - 'MAIL': '/var/mail/cltbld', 11:07:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:49 INFO - 'MOZ_NO_REMOTE': '1', 11:07:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:49 INFO - 'NO_EM_RESTART': '1', 11:07:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:07:49 INFO - 'PWD': '/builds/slave/test-pgo', 11:07:49 INFO - 'SHELL': '/bin/bash', 11:07:49 INFO - 'SHLVL': '1', 11:07:49 INFO - 'TERM': 'linux', 11:07:49 INFO - 'TMOUT': '86400', 11:07:49 INFO - 'USER': 'cltbld', 11:07:49 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1460052184.843169-905759111', 11:07:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:49 INFO - '_': '/tools/buildbot/bin/python'} 11:07:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:07:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:07:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:07:51 INFO - Installing collected packages: mozsystemmonitor 11:07:51 INFO - Running setup.py install for mozsystemmonitor 11:07:51 INFO - Successfully installed mozsystemmonitor 11:07:51 INFO - Cleaning up... 11:07:51 INFO - Return code: 0 11:07:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 11:07:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f44d9caaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29318d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c08b0>, '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 0x29c17b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c1c60>, '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': '574dc5aafe09851ec43d388c000001b6-1460052184.843169-905759111', '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 11:07:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 11:07:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:07:51 INFO - Using env: {'DISPLAY': ':0', 11:07:51 INFO - 'HOME': '/home/cltbld', 11:07:51 INFO - 'LANG': 'en_US.UTF-8', 11:07:51 INFO - 'LANGUAGE': 'en_US:en', 11:07:51 INFO - 'LOGNAME': 'cltbld', 11:07:51 INFO - 'MAIL': '/var/mail/cltbld', 11:07:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:51 INFO - 'MOZ_NO_REMOTE': '1', 11:07:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:51 INFO - 'NO_EM_RESTART': '1', 11:07:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:07:51 INFO - 'PWD': '/builds/slave/test-pgo', 11:07:51 INFO - 'SHELL': '/bin/bash', 11:07:51 INFO - 'SHLVL': '1', 11:07:51 INFO - 'TERM': 'linux', 11:07:51 INFO - 'TMOUT': '86400', 11:07:51 INFO - 'USER': 'cltbld', 11:07:51 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1460052184.843169-905759111', 11:07:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:51 INFO - '_': '/tools/buildbot/bin/python'} 11:07:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:51 INFO - Downloading/unpacking blobuploader==1.2.4 11:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:53 INFO - Downloading blobuploader-1.2.4.tar.gz 11:07:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:07:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:07: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 11:07: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 11:07: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 11:07: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 11:07: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 11:07: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 11:07:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 11:07:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:07: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 11:07: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 11:07: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 11:07: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 11:07: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 11:07: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 11:07:54 INFO - Downloading docopt-0.6.1.tar.gz 11:07:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 11:07:54 INFO - Installing collected packages: blobuploader, requests, docopt 11:07:54 INFO - Running setup.py install for blobuploader 11:07:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:07:54 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 11:07:54 INFO - Running setup.py install for requests 11:07:54 INFO - Running setup.py install for docopt 11:07:54 INFO - Successfully installed blobuploader requests docopt 11:07:54 INFO - Cleaning up... 11:07:54 INFO - Return code: 0 11:07:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:07:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:54 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 0x7f44d9caaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29318d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c08b0>, '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 0x29c17b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c1c60>, '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': '574dc5aafe09851ec43d388c000001b6-1460052184.843169-905759111', '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 11:07:54 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 11:07:54 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 11:07:54 INFO - Using env: {'DISPLAY': ':0', 11:07:54 INFO - 'HOME': '/home/cltbld', 11:07:54 INFO - 'LANG': 'en_US.UTF-8', 11:07:54 INFO - 'LANGUAGE': 'en_US:en', 11:07:54 INFO - 'LOGNAME': 'cltbld', 11:07:54 INFO - 'MAIL': '/var/mail/cltbld', 11:07:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:54 INFO - 'MOZ_NO_REMOTE': '1', 11:07:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:54 INFO - 'NO_EM_RESTART': '1', 11:07:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:07:54 INFO - 'PWD': '/builds/slave/test-pgo', 11:07:54 INFO - 'SHELL': '/bin/bash', 11:07:54 INFO - 'SHLVL': '1', 11:07:54 INFO - 'TERM': 'linux', 11:07:54 INFO - 'TMOUT': '86400', 11:07:54 INFO - 'USER': 'cltbld', 11:07:54 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1460052184.843169-905759111', 11:07:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:54 INFO - '_': '/tools/buildbot/bin/python'} 11:07:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:07:54 INFO - Running setup.py (path:/tmp/pip-ijC0k1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:07:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:07:55 INFO - Running setup.py (path:/tmp/pip-LWl8_Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:07:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:07:55 INFO - Running setup.py (path:/tmp/pip-IH6vXo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:07:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:07:55 INFO - Running setup.py (path:/tmp/pip-HdfDNr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:07:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:07:55 INFO - Running setup.py (path:/tmp/pip-soM9Zi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:07:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:07:55 INFO - Running setup.py (path:/tmp/pip-bYao1i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:07:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:07:55 INFO - Running setup.py (path:/tmp/pip-0_p1Dv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:07:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:07:55 INFO - Running setup.py (path:/tmp/pip-iBjxPO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:07:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:07:55 INFO - Running setup.py (path:/tmp/pip-WxZ8Kq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:07:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:07:55 INFO - Running setup.py (path:/tmp/pip-0r5dKU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:07:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:07:55 INFO - Running setup.py (path:/tmp/pip-3N4vE5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:07:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:07:55 INFO - Running setup.py (path:/tmp/pip-hK6bzy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:07:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:07:55 INFO - Running setup.py (path:/tmp/pip-WFRxWU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:07:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:07:55 INFO - Running setup.py (path:/tmp/pip-xqhz74-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:07:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:07:55 INFO - Running setup.py (path:/tmp/pip-fBpQ2E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:07:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:07:56 INFO - Running setup.py (path:/tmp/pip-hi4NyP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:07:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:07:56 INFO - Running setup.py (path:/tmp/pip-x3z0RS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:07:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:07:56 INFO - Running setup.py install for manifestparser 11:07:56 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 11:07:56 INFO - Running setup.py install for mozcrash 11:07:56 INFO - Running setup.py install for mozdebug 11:07:56 INFO - Running setup.py install for mozdevice 11:07:56 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 11:07:56 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 11:07:56 INFO - Running setup.py install for mozfile 11:07:56 INFO - Running setup.py install for mozhttpd 11:07:56 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 11:07:56 INFO - Running setup.py install for mozinfo 11:07:56 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 11:07:56 INFO - Running setup.py install for mozInstall 11:07:56 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 11:07:56 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 11:07:56 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 11:07:56 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 11:07:56 INFO - Running setup.py install for mozleak 11:07:57 INFO - Running setup.py install for mozlog 11:07:57 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 11:07:57 INFO - Running setup.py install for moznetwork 11:07:57 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 11:07:57 INFO - Running setup.py install for mozprocess 11:07:57 INFO - Running setup.py install for mozprofile 11:07:57 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 11:07:57 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 11:07:57 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 11:07:57 INFO - Running setup.py install for mozrunner 11:07:57 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 11:07:57 INFO - Running setup.py install for mozscreenshot 11:07:57 INFO - Running setup.py install for moztest 11:07:57 INFO - Running setup.py install for mozversion 11:07:57 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 11:07:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:07:57 INFO - Cleaning up... 11:07:57 INFO - Return code: 0 11:07:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:07:57 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')]} 11:07:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:57 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')]} 11:07:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:57 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 0x7f44d9caaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29318d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c08b0>, '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 0x29c17b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c1c60>, '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': '574dc5aafe09851ec43d388c000001b6-1460052184.843169-905759111', '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 11:07:57 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 11:07:57 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 11:07:57 INFO - Using env: {'DISPLAY': ':0', 11:07:57 INFO - 'HOME': '/home/cltbld', 11:07:57 INFO - 'LANG': 'en_US.UTF-8', 11:07:57 INFO - 'LANGUAGE': 'en_US:en', 11:07:57 INFO - 'LOGNAME': 'cltbld', 11:07:57 INFO - 'MAIL': '/var/mail/cltbld', 11:07:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:57 INFO - 'MOZ_NO_REMOTE': '1', 11:07:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:57 INFO - 'NO_EM_RESTART': '1', 11:07:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:07:57 INFO - 'PWD': '/builds/slave/test-pgo', 11:07:57 INFO - 'SHELL': '/bin/bash', 11:07:57 INFO - 'SHLVL': '1', 11:07:57 INFO - 'TERM': 'linux', 11:07:57 INFO - 'TMOUT': '86400', 11:07:57 INFO - 'USER': 'cltbld', 11:07:57 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1460052184.843169-905759111', 11:07:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:57 INFO - '_': '/tools/buildbot/bin/python'} 11:07:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:07:58 INFO - Running setup.py (path:/tmp/pip-OUiCGY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:07:58 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)) 11:07:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:07:58 INFO - Running setup.py (path:/tmp/pip-OrOSLD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:07:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 11:07:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:07:58 INFO - Running setup.py (path:/tmp/pip-4zWVM5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:07:58 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)) 11:07:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:07:58 INFO - Running setup.py (path:/tmp/pip-vZxgPK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:07:58 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)) 11:07:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:07:58 INFO - Running setup.py (path:/tmp/pip-x9O9YN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:07:58 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)) 11:07:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:07:58 INFO - Running setup.py (path:/tmp/pip-jDLKcz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:07:58 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)) 11:07:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:07:58 INFO - Running setup.py (path:/tmp/pip-Jrirre-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:07:58 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)) 11:07:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:07:58 INFO - Running setup.py (path:/tmp/pip-61Ahkk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:07:58 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)) 11:07:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:07:58 INFO - Running setup.py (path:/tmp/pip-3iHXK4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:07:58 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)) 11:07:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:07:58 INFO - Running setup.py (path:/tmp/pip-CzFVd1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:07:58 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)) 11:07:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:07:58 INFO - Running setup.py (path:/tmp/pip-O0ilwl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:07:58 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)) 11:07:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:07:58 INFO - Running setup.py (path:/tmp/pip-8PNAJX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:07:59 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)) 11:07:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:07:59 INFO - Running setup.py (path:/tmp/pip-nSw69U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:07:59 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)) 11:07:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:07:59 INFO - Running setup.py (path:/tmp/pip-wTIL1S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:07:59 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)) 11:07:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:07:59 INFO - Running setup.py (path:/tmp/pip-rAFLVR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:07:59 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)) 11:07:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:07:59 INFO - Running setup.py (path:/tmp/pip-rX6SIZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:07:59 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)) 11:07:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:07:59 INFO - Running setup.py (path:/tmp/pip-aRn5h5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:07:59 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)) 11:07:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 11:07:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 11:07:59 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)) 11:07:59 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)) 11:07:59 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)) 11:07:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 11:07:59 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 11:07:59 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 11:07:59 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 11:07:59 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 11:07:59 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 11:07:59 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 11:08:01 INFO - Downloading blessings-1.6.tar.gz 11:08:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 11:08:01 INFO - Installing collected packages: blessings 11:08:01 INFO - Running setup.py install for blessings 11:08:01 INFO - Successfully installed blessings 11:08:01 INFO - Cleaning up... 11:08:01 INFO - Return code: 0 11:08:01 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 11:08:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:08:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:08:01 INFO - Reading from file tmpfile_stdout 11:08:01 INFO - Current package versions: 11:08:01 INFO - argparse == 1.2.1 11:08:01 INFO - blessings == 1.6 11:08:01 INFO - blobuploader == 1.2.4 11:08:01 INFO - docopt == 0.6.1 11:08:01 INFO - manifestparser == 1.1 11:08:01 INFO - mozInstall == 1.12 11:08:01 INFO - mozcrash == 0.17 11:08:01 INFO - mozdebug == 0.1 11:08:01 INFO - mozdevice == 0.48 11:08:01 INFO - mozfile == 1.2 11:08:01 INFO - mozhttpd == 0.7 11:08:01 INFO - mozinfo == 0.9 11:08:01 INFO - mozleak == 0.1 11:08:01 INFO - mozlog == 3.1 11:08:01 INFO - moznetwork == 0.27 11:08:01 INFO - mozprocess == 0.22 11:08:01 INFO - mozprofile == 0.28 11:08:01 INFO - mozrunner == 6.11 11:08:01 INFO - mozscreenshot == 0.1 11:08:01 INFO - mozsystemmonitor == 0.0 11:08:01 INFO - moztest == 0.7 11:08:01 INFO - mozversion == 1.4 11:08:01 INFO - psutil == 3.1.1 11:08:01 INFO - requests == 1.2.3 11:08:01 INFO - wsgiref == 0.1.2 11:08:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:08:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:01 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 0x7f44d9caaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29318d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c08b0>, '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 0x29c17b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c1c60>, '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': '574dc5aafe09851ec43d388c000001b6-1460052184.843169-905759111', '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 11:08:01 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 11:08:01 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 11:08:01 INFO - Using env: {'DISPLAY': ':0', 11:08:01 INFO - 'HOME': '/home/cltbld', 11:08:01 INFO - 'LANG': 'en_US.UTF-8', 11:08:01 INFO - 'LANGUAGE': 'en_US:en', 11:08:01 INFO - 'LOGNAME': 'cltbld', 11:08:01 INFO - 'MAIL': '/var/mail/cltbld', 11:08:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:01 INFO - 'MOZ_NO_REMOTE': '1', 11:08:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:01 INFO - 'NO_EM_RESTART': '1', 11:08:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:08:01 INFO - 'PWD': '/builds/slave/test-pgo', 11:08:01 INFO - 'SHELL': '/bin/bash', 11:08:01 INFO - 'SHLVL': '1', 11:08:01 INFO - 'TERM': 'linux', 11:08:01 INFO - 'TMOUT': '86400', 11:08:01 INFO - 'USER': 'cltbld', 11:08:01 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1460052184.843169-905759111', 11:08:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:01 INFO - '_': '/tools/buildbot/bin/python'} 11:08:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:01 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)) 11:08:01 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)) 11:08:01 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)) 11:08:01 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)) 11:08:01 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)) 11:08:01 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)) 11:08:01 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)) 11:08:01 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)) 11:08:01 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)) 11:08:01 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)) 11:08:01 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)) 11:08:01 INFO - Cleaning up... 11:08:01 INFO - Return code: 0 11:08:01 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 11:08:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:01 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 0x7f44d9caaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29318d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c08b0>, '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 0x29c17b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c1c60>, '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': '574dc5aafe09851ec43d388c000001b6-1460052184.843169-905759111', '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 11:08:01 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 11:08:01 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 11:08:01 INFO - Using env: {'DISPLAY': ':0', 11:08:01 INFO - 'HOME': '/home/cltbld', 11:08:01 INFO - 'LANG': 'en_US.UTF-8', 11:08:01 INFO - 'LANGUAGE': 'en_US:en', 11:08:01 INFO - 'LOGNAME': 'cltbld', 11:08:01 INFO - 'MAIL': '/var/mail/cltbld', 11:08:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:01 INFO - 'MOZ_NO_REMOTE': '1', 11:08:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:01 INFO - 'NO_EM_RESTART': '1', 11:08:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:08:01 INFO - 'PWD': '/builds/slave/test-pgo', 11:08:01 INFO - 'SHELL': '/bin/bash', 11:08:01 INFO - 'SHLVL': '1', 11:08:01 INFO - 'TERM': 'linux', 11:08:01 INFO - 'TMOUT': '86400', 11:08:01 INFO - 'USER': 'cltbld', 11:08:01 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1460052184.843169-905759111', 11:08:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:01 INFO - '_': '/tools/buildbot/bin/python'} 11:08:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:02 INFO - Downloading/unpacking jsonschema 11:08:02 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 11:08:02 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 11:08:02 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 11:08:02 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 11:08:02 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 11:08:02 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 11:08:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:08:04 INFO - Downloading/unpacking functools32 (from jsonschema) 11:08:04 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 11:08:04 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 11:08:04 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 11:08:04 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 11:08:04 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 11:08:04 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 11:08:04 INFO - Downloading functools32-3.2.3-2.tar.gz 11:08:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 11:08:04 INFO - warning: no files found matching '*.txt' 11:08:04 INFO - no previously-included directories found matching 'build' 11:08:04 INFO - no previously-included directories found matching 'dist' 11:08:04 INFO - no previously-included directories found matching '.git*' 11:08:04 INFO - Installing collected packages: jsonschema, functools32 11:08:04 INFO - Running setup.py install for functools32 11:08:04 INFO - warning: no files found matching '*.txt' 11:08:04 INFO - no previously-included directories found matching 'build' 11:08:04 INFO - no previously-included directories found matching 'dist' 11:08:04 INFO - no previously-included directories found matching '.git*' 11:08:04 INFO - Successfully installed jsonschema functools32 11:08:04 INFO - Cleaning up... 11:08:04 INFO - Return code: 0 11:08:04 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 11:08:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:04 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 0x7f44d9caaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29318d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c08b0>, '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 0x29c17b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c1c60>, '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': '574dc5aafe09851ec43d388c000001b6-1460052184.843169-905759111', '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 11:08:04 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 11:08:04 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 11:08:04 INFO - Using env: {'DISPLAY': ':0', 11:08:04 INFO - 'HOME': '/home/cltbld', 11:08:04 INFO - 'LANG': 'en_US.UTF-8', 11:08:04 INFO - 'LANGUAGE': 'en_US:en', 11:08:04 INFO - 'LOGNAME': 'cltbld', 11:08:04 INFO - 'MAIL': '/var/mail/cltbld', 11:08:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:04 INFO - 'MOZ_NO_REMOTE': '1', 11:08:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:04 INFO - 'NO_EM_RESTART': '1', 11:08:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:08:04 INFO - 'PWD': '/builds/slave/test-pgo', 11:08:04 INFO - 'SHELL': '/bin/bash', 11:08:04 INFO - 'SHLVL': '1', 11:08:04 INFO - 'TERM': 'linux', 11:08:04 INFO - 'TMOUT': '86400', 11:08:04 INFO - 'USER': 'cltbld', 11:08:04 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1460052184.843169-905759111', 11:08:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:04 INFO - '_': '/tools/buildbot/bin/python'} 11:08:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:04 INFO - Downloading/unpacking flake8 11:08:04 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 11:08:04 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 11:08:04 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 11:08:04 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 11:08:04 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 11:08:04 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 11:08:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:08:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:08:06 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 11:08:06 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 11:08:06 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 11:08:06 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 11:08:06 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 11:08:06 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 11:08:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:08:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:08:06 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 11:08:06 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 11:08:06 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 11:08:06 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 11:08:06 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 11:08:06 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 11:08:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:08:07 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 11:08:07 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 11:08:07 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 11:08:07 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 11:08:07 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 11:08:07 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 11:08:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 11:08:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:08:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:08:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:08:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:08:07 INFO - no previously-included directories found matching 'docs/_build' 11:08:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:08:07 INFO - Running setup.py install for pep8 11:08:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:08:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:08:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:08:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:08:07 INFO - no previously-included directories found matching 'docs/_build' 11:08:07 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 11:08:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:08:07 INFO - Cleaning up... 11:08:07 INFO - Return code: 0 11:08:07 INFO - Running post-action listener: _resource_record_post_action 11:08:07 INFO - Running post-action listener: _start_resource_monitoring 11:08:07 INFO - Starting resource monitoring. 11:08:07 INFO - ##### 11:08:07 INFO - ##### Running install step. 11:08:07 INFO - ##### 11:08:07 INFO - Running pre-action listener: _resource_record_pre_action 11:08:07 INFO - Running main action method: install 11:08:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:08:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:08:07 INFO - Reading from file tmpfile_stdout 11:08:07 INFO - Detecting whether we're running mozinstall >=1.0... 11:08:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 11:08:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 11:08:08 INFO - Reading from file tmpfile_stdout 11:08:08 INFO - Output received: 11:08:08 INFO - Usage: mozinstall [options] installer 11:08:08 INFO - Options: 11:08:08 INFO - -h, --help show this help message and exit 11:08:08 INFO - -d DEST, --destination=DEST 11:08:08 INFO - Directory to install application into. [default: 11:08:08 INFO - "/builds/slave/test-pgo"] 11:08:08 INFO - --app=APP Application being installed. [default: firefox] 11:08:08 INFO - mkdir: /builds/slave/test-pgo/build/application 11:08:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 11:08:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 11:08:24 INFO - Reading from file tmpfile_stdout 11:08:24 INFO - Output received: 11:08:24 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 11:08:24 INFO - Running post-action listener: _resource_record_post_action 11:08:24 INFO - ##### 11:08:24 INFO - ##### Running run-tests step. 11:08:24 INFO - ##### 11:08:24 INFO - Running pre-action listener: _resource_record_pre_action 11:08:24 INFO - Running main action method: run_tests 11:08:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 11:08:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 11:08:24 INFO - Python 2.7.3 11:08:24 INFO - Return code: 0 11:08:24 INFO - grabbing minidump binary from tooltool 11:08:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:24 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 0x29c08b0>, '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 0x29c17b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c1c60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 11:08:24 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 11:08:24 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 11:08:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:08:24 INFO - Return code: 0 11:08:24 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 11:08:24 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 11:08:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 11:08:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 11:08:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 11:08:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 11:08:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 11:08:25 INFO - Return code: 0 11:08:25 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ezcu_2ZaTbuOlhEKrw47fQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 11:08:25 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-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ezcu_2ZaTbuOlhEKrw47fQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-044 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:08:25 INFO - Using env: {'DISPLAY': ':0', 11:08:25 INFO - 'HOME': '/home/cltbld', 11:08:25 INFO - 'LANG': 'en_US.UTF-8', 11:08:25 INFO - 'LANGUAGE': 'en_US:en', 11:08:25 INFO - 'LOGNAME': 'cltbld', 11:08:25 INFO - 'MAIL': '/var/mail/cltbld', 11:08:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:08:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 11:08:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:25 INFO - 'MOZ_NO_REMOTE': '1', 11:08:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:08:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:25 INFO - 'NO_EM_RESTART': '1', 11:08:25 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:08:25 INFO - 'PWD': '/builds/slave/test-pgo', 11:08:25 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 11:08:25 INFO - 'SHELL': '/bin/bash', 11:08:25 INFO - 'SHLVL': '1', 11:08:25 INFO - 'TERM': 'linux', 11:08:25 INFO - 'TMOUT': '86400', 11:08:25 INFO - 'USER': 'cltbld', 11:08:25 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1460052184.843169-905759111', 11:08:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:25 INFO - '_': '/tools/buildbot/bin/python'} 11:08:25 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ezcu_2ZaTbuOlhEKrw47fQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:08:25 INFO - mozversion application_buildid: 20160407083318 11:08:25 INFO - mozversion application_changeset: f5d7c57cdfd7574361db3a1b555db546c4ccaf22 11:08:25 INFO - mozversion application_display_name: Nightly 11:08:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:08:25 INFO - mozversion application_name: Firefox 11:08:25 INFO - mozversion application_remotingname: firefox 11:08:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:08:25 INFO - mozversion application_vendor: Mozilla 11:08:25 INFO - mozversion application_version: 48.0a1 11:08:25 INFO - mozversion platform_buildid: 20160407083318 11:08:25 INFO - mozversion platform_changeset: f5d7c57cdfd7574361db3a1b555db546c4ccaf22 11:08:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:08:25 INFO - mozversion platform_version: 48.0a1 11:08:25 INFO - using testdate: 1460052505 11:08:25 INFO - actual date: 1460052505 11:08:25 INFO - starting webserver on 'localhost:39972' 11:08:25 INFO - SUITE-START | Running 2 tests 11:08:25 INFO - TEST-START | dromaeo_css 11:08:25 INFO - operating with platform_type : linux_ 11:08:25 INFO - Initialising browser for dromaeo_css test... 11:08:25 INFO - TEST-INFO | started process 18515 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpp39Cyd/profile http://localhost:39972/getInfo.html) 11:08:29 INFO - PROCESS | 18515 | 11:08:29 INFO - PROCESS | 18515 | (process:18584): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:08:29 INFO - PROCESS | 18515 | JavaScript error: jar:file:///builds/slave/test-pgo/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 11:08:30 INFO - PROCESS | 18515 | __metrics Screen width/height:1600/1200 11:08:30 INFO - PROCESS | 18515 | colorDepth:24 11:08:30 INFO - PROCESS | 18515 | Browser inner width/height: 1024/697 11:08:30 INFO - PROCESS | 18515 | __metrics 11:08:31 ERROR - PROCESS | 18515 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2881: TypeError: this.tabs is undefined 11:08:32 INFO - TEST-INFO | 18515: exit 0 11:08:32 INFO - Browser initialized. 11:08:32 INFO - Running cycle 1/1 for dromaeo_css test... 11:08:32 INFO - TEST-INFO | started process 18635 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpp39Cyd/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:08:33 INFO - PROCESS | 18635 | 11:08:33 INFO - PROCESS | 18635 | (process:18694): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:08:43 INFO - PROCESS | 18635 | RSS: Main: 163446784 11:08:43 INFO - PROCESS | 18635 | 11:09:33 INFO - PROCESS | 18635 | 1460052573528 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] 11:11:40 INFO - PROCESS | 18635 | Cycle 1(1): loaded http://localhost:39972/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39972/tests/dromaeo/cssquery-ext.html) 11:11:41 INFO - PROCESS | 18635 | RSS: Main: 167813120 11:11:41 INFO - PROCESS | 18635 | 11:14:43 INFO - PROCESS | 18635 | Cycle 1(1): loaded http://localhost:39972/tests/dromaeo/cssquery-ext.html (next: http://localhost:39972/tests/dromaeo/cssquery-jquery.html) 11:14:44 INFO - PROCESS | 18635 | RSS: Main: 164749312 11:14:44 INFO - PROCESS | 18635 | 11:17:45 INFO - PROCESS | 18635 | Cycle 1(1): loaded http://localhost:39972/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39972/tests/dromaeo/cssquery-mootools.html) 11:17:46 INFO - PROCESS | 18635 | RSS: Main: 165785600 11:17:46 INFO - PROCESS | 18635 | 11:20:48 INFO - PROCESS | 18635 | Cycle 1(1): loaded http://localhost:39972/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39972/tests/dromaeo/cssquery-prototype.html) 11:20:48 INFO - PROCESS | 18635 | RSS: Main: 163536896 11:20:48 INFO - PROCESS | 18635 | 11:23:51 INFO - PROCESS | 18635 | Cycle 1(1): loaded http://localhost:39972/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39972/tests/dromaeo/cssquery-yui.html) 11:23:51 INFO - PROCESS | 18635 | RSS: Main: 164732928 11:23:51 INFO - PROCESS | 18635 | 11:26:54 INFO - PROCESS | 18635 | Cycle 1(1): loaded http://localhost:39972/tests/dromaeo/cssquery-yui.html (next: http://localhost:39972/tests/dromaeo/cssquery-dojo.html) 11:26:54 INFO - PROCESS | 18635 | RSS: Main: 166551552 11:26:54 INFO - PROCESS | 18635 | 11:26:54 INFO - PROCESS | 18635 | __start_tp_report 11:26:54 INFO - PROCESS | 18635 | _x_x_mozilla_page_load 11:26:54 INFO - PROCESS | 18635 | _x_x_mozilla_page_load_details 11:26:54 INFO - PROCESS | 18635 | |i|pagename|runs| 11:26:54 INFO - PROCESS | 18635 | |0;dojo.html;3097.8141311521313;3168.762342824288;3189.4259033373996;3207.711305982461;3231.8384080795954;5420.105682562373;5430.185472179175;5432.375276843164;5451.3871656161555;5464.26232458618;5369.355677318717;5394.757235924383;5466.508014278714;5496.972515137419;5517.172424136382;4950.6782059166035;4955.628327875405;4975.925361119586;5040;5083.364579427572;5021.196608542634;5024.422191447976;5061.569766569846;5078.13671675816;5111.4121875984365;4850.975745121269;4912.943717100805;4915.8525244242555;4960.727160006199;5023.120953833083;4928.383952005999;4963.6277279204205;4964.230544265644;4964.87587810304;4972.552470277692;4884.535969082932;4916.729579873106;4920.606351491872;4962.801487940478;5015.924761128586;5148.433672296044;5297.523222909918;5350.35795704514;5360.678359298455;5363.678179309254;5762.855928601818;5779.219805326269;5780.017397042471;5787.884242315172;5802.535797136219;5792.652440853562;5829.766809327622;5835.79574714883;5846.561507886926;5861.6483011019045;5460.426655201226;5493.478119578634;5511.669299841982;5528.170774383834;5552.750126244328;5849.912251316234;5852.034414321589;5860.501857342174;5880.588358814842;5892.057270836645;5656.547476201894;5669.489745922887;5672.574556908248;5692.715364231772;5738.569607279471;5729.312482502127;5747.827565173052;5748.051571490741;5750.108733146369;5753.626014309057;5633.126865335879;5661.943380566224;5697.287839020122;5734.627249228787;5767.596268261182;5720.628159169641;5798.304203495608;5815.76736930518;5847.298324201038;5857.707114644336;4295.205387003414;4296.613304802583;4350.651947844165;4354.129174165179;4375.5405682403525;3866.4586957825927;3887.2031233597045;3891.2217556488818;3911.765294082364;3929.174873276587;5370.489803468664;5497.422770609109;5549.889002219933;5574.777008919679;5585.357683866326;5851.882962340729;5857.502112320415;5899.793507227227;5907.763689452459;5925.229720136441;5534.584906132056;5539;5556.361018482846;5558.527525160407;5602.607817452821;4896.216605343128;4950.3069570260195;4972.875678108004;5002.949970500248;5037.4458809530925;5967.313758917693;5967.433093856077;5967.806438712275;5982.9401705983255;6003.549733769984;5767.769289228468;5820.563457740602;5829.766809327749;5834.15404766315;5848.268966379118;5833.416658334133;5866.472017518444;5891.528677705859;5922.526197904243;6078.3617720138745;5644.068728659725;5653.406392328746;5665.773369065356;5671.489565939085;5703.230063941315;5759.625624334405;5780.971095144666;5842.1820945066875;5854;5868.677222752619;5647.237622920853;5700.458456446631;5735.541156707537;5741.110127930177;5755.625884317506;5648.661080335193;5662.065759149694;5674.829755107354;5677.403872593318;5725.141228815711;5581.804636837691;5582.86042848932;5592.748326325243;5594;5619.438056194348;5637.379888212211;5659.349174844946;5708.372079071216;5762.510186634183;5794.82615521535;5603.943960560342;5653.943460565341;5654.604177707521;5659.85850353728;5667.149927510906 11:26:54 INFO - PROCESS | 18635 | |1;ext.html;555.2115995286692;570.1826273101584;578.6846168837983;596.6509591888746;676.8443258050645;35911;36470;36507.81746091266;36721.816390918044;36725.26549469009;37403.25193496135;37828.62171378286;38061;38103.61896381035;38211.23577528455;8519.361047921415;8726.607302671395;8870.290376769875;8886.333524985619;8886.422382545146;8706.434081784695;8723;8792.69225577105;8846.115388461167;8849.690260840873;8816.515091669955;8901.287896968228;8906.198442140207;8914.153155450254;8924.8661270081;8772.692955746583;8814.647414103429;8855;8869;8879.200871921494;8706.869396959051;8711.085336039689;8871.201591856763;8901.73294801157;8905.198532132139;37432;37468.25063498715;37653.62346376529;37823.432648510294;37856.43215351772;3543.6633519815578;3549.8580056797696;3563.6614521620404;3567.928641427157;3664.2121943782213;30381;30680;30831.229219269473;31269.37461250762;31299.687003130133;4127.731697439657;4196.517400498951;4244.915101697949;4291.785410729451;4379.394832772269;326023;327144;327764;328401;329118;62911.685441572496;63126.36873631205;63309.36690633127;63321;63620;65973.67013164904;66879;67212.66393668001;67285;67371.32628673749;17195.31218751261;17466.126693665265;17469.301227950993;17538.03540805268;17606.647867042586;13062.367204099488;13092.214467131813;13119.344032798514;13119.475220991244;13130.803037954438;21404.892975535022;21475.892620536797;21488.14047438085;21599.35201943944;21602.675959860302;7868.173841746649;7898.9210107899335;8082.474639148437;8216.26053655162;8219.068558864634;1110.1618278199908;1141.3494308244221;1163.988360116405;1178.9919618725867;1214.5081242096965;30810;31320.373592528023;31669.36661266808;31720.206994825316;32162;1146.2835727670206;1186.4008675618757;1215.8966487848454;1218.7623413434474;1297.6496345986532;14293.142411455347;14688.118712877262;14706.33821478036;14719.92640036793;15010.549683509513;374608;528612;536061.4347780482;539762;541525;58563;58917;59310.406895930486;59322;59334;1394.4631316942848;1403.3123769352944;1415.9362828672733;1422.6443389152712;1431.4775107085838;31376.215594610316;32260.19349516281;32433.837830810695;32924.17689557684;32975;48418;49090;49120;49658.50341496539;49687.50312496829;367378;370308;371101;371532;371646;34975.300493990486;35801.46297805483;36088.4586731194;36119.09702257464;36337;43867;44360.77819610881;44788.77605611951;45464.31803522884;46117;38325.808370957966;38776.80611596924;38867.22265554617;39229.607703923735;39955;37229.255414891006;37941.86174414772;38247.80876095713;38317.80841095777;38483.42274865823;33903;38256.808715957355;39069.41395879121;39150.41274380944;39424.40863387109;30618.693813061585;31111.66662500367;31296.530552042193;31319.373612528078;31385.05844824659;24965;25266.74733252644;25979.61030584505;26093.608595870697;27269.86365068162 11:26:54 INFO - PROCESS | 18635 | |2;jquery.html;354.7073664227012;358.6431500656845;359.39083253884667;365.0763568172524;365.3040956976958;17375.65248695027;17476.56308592286;19058.142383592738;19118.33085841996;19240.51898702533;17711.1144442778;18159.72760408595;18241.45275641733;18298.63402731948;18326.633467330645;5205.973970130144;5424.918626220609;5444.91832622509;5448.945510544883;5457.672539647634;5405.324334458192;5465.945340546603;5525.281713377255;5528.44715528448;5534.363548191969;5275.947240527603;5337.67973921564;5352.063388906945;5363.115086010804;5372.086745253317;5279.841604751844;5330.200469929503;5337.332833395806;5366.70483123428;5369.543588794957;4725.3384526166365;4778.856634300942;4786.664933454659;4809.95190048102;4834.879128021792;21390.251341202984;21414.357569272946;21574.676379854314;21626.783732162636;21845.781542184694;2384.4277373430427;2441.6337549367736;2507.561176794072;2740.6985231624503;2915.950257907152;13331.133476324105;13502.392392342368;13612.319384030858;13716.794248086288;13881.930590347085;1854.2304943448453;1930.3533316339044;1953.3944477211967;1954.3355259211794;2041.4692180033298;66647;68207.3179268211;68999.65500172468;69198.99999999949;69672.12295139342;9404.38871473352;9418;9974.950125249326;10308.793824123475;10675.306105103144;13559.25424101664;13773.862261377259;13783.724325513434;13821.516246931309;13856.93071534636;7877.724279650185;7937.444378893422;7999.800004999922;8041.3968952328805;8161.469504482189;7746.728864489828;7890.289873911375;7999.0801057877925;8025.03699556057;8037.598120093972;6053.182820319289;6082.422169893853;6142.662153581507;6170.197874276405;6225.533085018642;1790.4539115569617;1836.7887692915485;1837.6692195404955;1841.208280439424;1875.2030387085433;915.9084091590921;1010.6462738041627;1021.3055122516612;1055.7518983038979;1144.4678224625588;17862.374816881347;18170.727439088423;18203.362882299058;18343.633127337645;18924.810751892306;1019.8623185869961;1037.7301901505664;1041.588572513868;1057.545255540125;1102.8511150994673;10216.335938163995;10663.146948244123;10708.982646648556;10728.088112510524;10742.194335424874;472221;494035;500771;503239;505330;50934.74532627313;59790.40209597848;62085.37914620796;68257.31742682609;70957.29042709507;1060;1085.6742977106837;1087.3747595132672;1098.0721290509507;1115.4088333183427;16007.759883601988;16291;16351.59121021984;16406.425775097814;16818.243179057215;35127.487251274666;36328.63671363358;36354.818225908704;37951.240975180895;38005.23989520139;52751;53793.462065378844;54182;54388;54650;8265.917340826514;8298.087210406971;8356.289715374018;8388.874166887623;8476.23713865755;11923.463444145207;12094.516219351128;12617.369131543202;12636;12849.293288868828;10261.692149235534;10723.356598604109;11182.944085279521;11334.206605537533;11410.14423918193;10917.23579349438;10993.780124397308;11008.559657613605;11090.778184436427;11484.19610627248;10863.841118936874;11225.494852731483;11555.88444115548;11567.88432115668;11711.063114950954;7775.416843736629;7924.286814186751;8046.597670116588;8084.272415482635;8108.3513318933165;10419.270651054656;11240.718982025515;11287.435628218393;11347;11355.37545434976 11:26:54 INFO - PROCESS | 18635 | |3;mootools.html;1477.903936244144;1497.348653335799;1664.750287456882;1776.5647416382988;1807.6294359656272;6942.4446044316455;7568.129665088516;7693;7916.564588947605;7945.880811787828;7718.922810771891;7745.496542724733;7833.686652533892;7834.255745704163;7844.137144914069;2279.5896738587007;2290.3815969688176;2308.7806658367426;2314.710661167354;2319.304208737372;2269.602819506588;2273.2611901132113;2321.872297023663;2325.6744055832196;2326.9534609307802;2284.246198754407;2290.209877592228;2302.3783578433813;2345.413646588353;2351.635496498037;2301.551197516485;2306.2158865985643;2307.7807608277185;2313.9190128345426;2321.6053270943894;2232.7878851509245;2249.0329158461855;2250.8762018089;2252.279270633398;2258.7515373308925;7940.047194336659;7949.205079492062;7958.283754462126;7959.323457506119;7965.761027169194;4895.6083513318845;5028.32117664118;5036.823711170092;5043.873903152414;5050.646454748169;3115.2679120406688;3125.0624812556143;3242.270489139925;3267.232200432896;3267.3791979524053;996.0338471682456;1004.6734811186394;1012.8126296635146;1031.582209205273;1044.216837371971;10325.690229293134;10486.475676216234;10523.421211833345;10537.473126343652;10542.156627469783;4382.649388048949;4408.338749187647;4480.081583275421;4493.078918821634;4533.750643714561;8940.418872773249;8965.775855603531;8989.865152022725;9021.909780902239;9022.909770902339;5017;5026.949730502722;5045.974770126126;5060.5698515625845;5065.822696205689;4029.3351596986167;4582.289745089516;4594.264917613166;4618.284165954283;4694.389729335165;3691.8338674759702;3761.9435708464393;3764.4917936078277;3790.0903783092413;3809.657130858236;1251.9624411267494;1255.9497620095276;1263.7219811641423;1273.4333221716247;1298.3573131300068;1120.5461787975883;1133.0482394788417;1143.2968724234536;1362.1622702038374;1434.103685196752;7247.311505406978;7353.338199561958;7372.299631534996;7562.697492100255;7612.048493938258;450.73181457033013;460.41297345884266;465.9138059459011;473.76548608438355;502.7310388941972;5887.087501437284;5890.558208134407;5905.793297234576;5915.053591425351;5921.822345329647;9114.498702571289;9335.953320233355;9527.666531671497;9558.378705384128;9589.089036541518;9497.43015419077;9511.57197926095;9527.047295270417;9580.281478889112;9631.71104866855;7043.964780176067;7205.675744591506;7208.71165153388;7218.675159617725;7398;7639.770806875803;7719.768406947801;7725.420593455626;7740.729074482366;7750.418718596241;8469.703560375357;8741.825163496822;8812.074732153287;8915.598798054232;8951.149640784115;8838.779030524289;8904;8904.599293031959;8944.239739622206;9003.189712925869;6230.314665386713;6722.428593569602;6888.896666549906;7133.964330178316;7148.142222933281;7484.775456736306;7497.325240728361;7506.662200201114;7508.887366689395;7526.5107767994905;6604.768833090819;6652.2349929756765;6682.532222744361;6715.26132125456;6903.723851046103;6911.101556797786;6926.06498122747;6967.407770339375;6998.5101042928545;7091.468139889425;7035.381862171832;7237.565746055254;7336.229695881855;7358;7362.484626076123;6659.633720145439;6693.765718199839;6733.293004234681;6739;6772.93227067723;6689.498287628545;6782.660866956534;6800;6810;6830.795076147723 11:26:54 INFO - PROCESS | 18635 | |4;prototype.html;339.35353152244966;343.27740107074607;349.50021469298895;350.100242377091;351.0609120602388;6430.935690643092;6493.220813502375;6496.992966090252;6520.4131628153455;6521.739130434783;6376.139221205136;6385.712642931067;6476.935230647692;6478.157839480861;6481.384268494486;4876.951230487694;4877.5366340197625;4880.658353915227;4880.731559764212;4883.218685010399;4643.094596553673;4711.575958163765;4895.31465594817;4897.118518666656;4899.044686286175;4701.106789709961;4722.669413141081;4778.307145463906;4788.664793464459;4791.712497250176;4774.498677638832;4781.976090119527;4783.995360974182;4790.377250957354;4792.472827988919;4197.790110494463;4201.831926722927;4203.159368126357;4204.978975105136;4229.090745489703;6101.206843110367;6120.112583675342;6158.353372895871;6163;6193.845153871144;5601.439856014406;5619.93221287954;5621.606487545832;5625.184348269478;5630.718464076821;6468.708908099147;6713.832154196135;6720.966395168041;6727.529072964894;6732.93267067328;4562.5665561771575;4573.879399547099;4575.542445755431;4578.977105114486;4582.862514124548;6865.9313406865795;6964.860702785966;7017.964910175417;7022.157341119098;7034.683439245297;4655.348251244828;4657.04530571232;4658.277966915133;4660.627149828073;4663.067386522709;4705.482396936334;4708.976455117702;4720.858374248778;4722.456917454468;4733.171694953369;5547.140193270049;5549.306336707911;5554.333479982428;5554.77780888768;5562.137868630369;6786.321367863273;6801.285864984205;6802.387785099365;6807.183138023469;6808.3191680832515;1632.7795747574164;1632.8122265939332;1667.1914121650989;1670.8245634208477;1674.4474323473225;1070.6252811515908;1092.8524649172418;1093.1691914145306;1102.1568500097433;1105.4748994227677;6414.102025716404;6464.321246269074;6471.9029214561815;6488.221413430324;6515.674216289167;6885.621290828953;6932.445404367639;6965.547239429421;6969.546979446422;6970.686319115652;6409.230892292955;6417.39034791694;6418.582792118497;6426.325235850262;6429.9678501607195;3706.1105334720014;3750.9249815003545;3754.8122593870744;3788.734788564774;3805.8858234253016;7159.96420017907;7264.854702906018;7283.854322913512;7311.561306321638;7315.780526584211;7200.279972002862;7225.5664660120565;7227.096612923385;7232.529885557422;7237.529560578546;7233.529820561752;7260.6006669632625;7326.743563975236;7345.338919497164;7373.8156546086775;6963.09479767627;6966.094407726963;7015.088038554955;7104.786856394317;7110.1112360954885;6930.099087118642;6956.130483689539;6956.373926346653;6969.54697944632;6971.930280697128;7333.523320984119;7347.8163045924275;7351.485396022227;7351.889721654073;7352.669129889275;4675.275332323496;4697.9530204698885;4699.553542413465;4701.247800351927;4740.2178640523925;6849.623270720158;7085.858282834211;7096.006559081836;7098.396636285974;7112;6804.523683342119;6860;6881.724731010904;6887.345702158487;6894.517383783087;6848.246692863681;6856.485763567653;6862.828429289308;6878.140232470942;6882.965585172042;6756.831079222862;6766.5263431559315;6768.796936091925;6782.830429239309;6783.830404239933;6742.595444273359;6848.657567121723;6861;6907.585544867324;6941.167059952838;6756.223034350916;6771.052052712525;6778.118844550177;6785.2536221016635;6785.59286442815 11:26:54 INFO - PROCESS | 18635 | |5;yui.html;715.3954908102652;725.8403151306712;737.8450525389668;753.0850017229066;769.5690413368518;14565.781513277296;14730.926345368258;14758.262086895666;14776.704465910689;14801.481948131817;12803.871961280385;13223.669408264797;13501.527446539372;13609.523666671645;13626.250556219404;810.3760104719363;813.4915677701437;818.5252553518975;819.0826274572487;821.8356328734247;813.4996976859248;814.633414963266;814.7922279818638;814.9429539932207;820.1552401026952;851.8466675998318;855.5593869157358;858.3648100405686;858.6908712863365;860.6858496648741;848.7708318753932;851.3997631669689;854.3677678517852;854.9358798090168;858.7767180533044;632.1308201223318;632.6172665537375;633.7781776378276;633.9049142628643;636.360457739973;13250.602481925558;13322.467101315935;13324.733505329936;13340.266285354302;13374.264415457146;11966.880331196751;12016;12022.63932082039;12134.514619415213;12190.47619047619;10358.43028633425;10364.067233948905;10695.946520267427;12075.879241207564;12078.456469458895;4429.867103986886;4454.109178164348;4465.196264672358;4587.380703605004;4602.493725690171;52487.47512524864;53330.73334633302;53389.733051334886;53449.73275133599;53592.73203633957;10405;10561.841572376266;10571.894281057244;10689.625863094754;10818.513166907507;18800.153993070344;18855.717164242546;18861.245550178115;19005.14476848545;19009.524761881064;7955;7968.12350641429;8116.675332986614;8149.877751833727;8255.339572834158;4686.671932964728;4687.578117969331;4742.170120228946;4770.499097594772;4898.118338698997;3492.511048453219;3519.560054993126;3534.8762793302626;3541.805200713934;3545.0782796472586;609.5458883132095;614.8063360041573;614.9692515374303;616.6022915219659;628.023423576334;646.5151136647514;654.9181352330959;692.9584224946519;723.0925188888017;748.5620911766568;8878.28973682104;8916.910830891738;8985.820283594292;9002.279817614575;9117.452952822852;650.8242774450872;665.7636539028672;673.0409166937095;737.2885165814907;759.9230130350629;4159.1491786155475;4389.6927215095275;4408.228560001987;4426.955730442654;4435.889102772457;55308.72345638246;55517.16724249139;55812.441875581535;55901;56023.71988140115;53955;55787;56351.43648563544;56576.717116414155;56625;44787.328190077176;48346.27480587794;50974.221593710274;51293.48706512887;51459.742701287;9383.812323753624;9473.47895865734;9514.33399662017;9644.75888102803;9672.129508344282;37751.43372849355;37976;38403.42394864024;38459.23081538409;39081.413778792776;43803.78098109489;44092.33861492016;47450;48184.27723584079;49618;11841.23032002917;11954.282743035446;12265.202761820454;12319.9384003083;12369.257844529357;13276.336183190995;13351.332433378486;13424.328783560979;13727.107737996997;14269.429222831386;11817.645470635895;11842.348670823187;11996.220245684002;12164.330961797186;12288.75422491563;12455;12672.176308539916;12995.220286782824;13001;13006.284654344103;12496.50628868052;12536.811947820972;12564.811527827273;12884.677883052998;12889.291088990196;10479.10927571165;10751.892481075402;10849.511771970438;10873.238873278795;10882.45587720595;10623.946880265548;10625.25623206368;10698.732531686459;10988.505517251902;11152.330860148093 11:26:54 INFO - PROCESS | 18635 | __end_tp_report 11:26:54 INFO - PROCESS | 18635 | __start_cc_report 11:26:54 INFO - PROCESS | 18635 | _x_x_mozilla_cycle_collect,340 11:26:54 INFO - PROCESS | 18635 | __end_cc_report 11:26:54 INFO - PROCESS | 18635 | __startTimestamp1460053614362__endTimestamp 11:26:54 INFO - PROCESS | 18635 | 11:26:54 INFO - PROCESS | 18635 | ------- Summary: start ------- 11:26:54 INFO - PROCESS | 18635 | Number of tests: 6 11:26:54 INFO - PROCESS | 18635 | 11:26:54 INFO - PROCESS | 18635 | [#0] dojo.html Cycles:165 Average:5391.32 Median:5637.38 stddev:609.31 (10.8%) stddev-sans-first:584.01 11:26:54 INFO - PROCESS | 18635 | Values: 3097.8 3168.8 3189.4 3207.7 3231.8 5420.1 5430.2 5432.4 5451.4 5464.3 5369.4 5394.8 5466.5 5497.0 5517.2 4950.7 4955.6 4975.9 5040.0 5083.4 5021.2 5024.4 5061.6 5078.1 5111.4 4851.0 4912.9 4915.9 4960.7 5023.1 4928.4 4963.6 4964.2 4964.9 4972.6 4884.5 4916.7 4920.6 4962.8 5015.9 5148.4 5297.5 5350.4 5360.7 5363.7 5762.9 5779.2 5780.0 5787.9 5802.5 5792.7 5829.8 5835.8 5846.6 5861.6 5460.4 5493.5 5511.7 5528.2 5552.8 5849.9 5852.0 5860.5 5880.6 5892.1 5656.5 5669.5 5672.6 5692.7 5738.6 5729.3 5747.8 5748.1 5750.1 5753.6 5633.1 5661.9 5697.3 5734.6 5767.6 5720.6 5798.3 5815.8 5847.3 5857.7 4295.2 4296.6 4350.7 4354.1 4375.5 3866.5 3887.2 3891.2 3911.8 3929.2 5370.5 5497.4 5549.9 5574.8 5585.4 5851.9 5857.5 5899.8 5907.8 5925.2 5534.6 5539.0 5556.4 5558.5 5602.6 4896.2 4950.3 4972.9 5002.9 5037.4 5967.3 5967.4 5967.8 5982.9 6003.5 5767.8 5820.6 5829.8 5834.2 5848.3 5833.4 5866.5 5891.5 5922.5 6078.4 5644.1 5653.4 5665.8 5671.5 5703.2 5759.6 5781.0 5842.2 5854.0 5868.7 5647.2 5700.5 5735.5 5741.1 5755.6 5648.7 5662.1 5674.8 5677.4 5725.1 5581.8 5582.9 5592.7 5594.0 5619.4 5637.4 5659.3 5708.4 5762.5 5794.8 5603.9 5653.9 5654.6 5659.9 5667.1 11:26:54 INFO - PROCESS | 18635 | 11:26:54 INFO - PROCESS | 18635 | [#1] ext.html Cycles:180 Average:56432.15 Median:37560.94 stddev:108424.73 (288.7%) stddev-sans-first:108647.72 11:26:54 INFO - PROCESS | 18635 | Values: 555.2 570.2 578.7 596.7 676.8 35911.0 36470.0 36507.8 36721.8 36725.3 37403.3 37828.6 38061.0 38103.6 38211.2 8519.4 8726.6 8870.3 8886.3 8886.4 8706.4 8723.0 8792.7 8846.1 8849.7 8816.5 8901.3 8906.2 8914.2 8924.9 8772.7 8814.6 8855.0 8869.0 8879.2 8706.9 8711.1 8871.2 8901.7 8905.2 37432.0 37468.3 37653.6 37823.4 37856.4 3543.7 3549.9 3563.7 3567.9 3664.2 30381.0 30680.0 30831.2 31269.4 31299.7 4127.7 4196.5 4244.9 4291.8 4379.4 326023.0 327144.0 327764.0 328401.0 329118.0 62911.7 63126.4 63309.4 63321.0 63620.0 65973.7 66879.0 67212.7 67285.0 67371.3 17195.3 17466.1 17469.3 17538.0 17606.6 13062.4 13092.2 13119.3 13119.5 13130.8 21404.9 21475.9 21488.1 21599.4 21602.7 7868.2 7898.9 8082.5 8216.3 8219.1 1110.2 1141.3 1164.0 1179.0 1214.5 30810.0 31320.4 31669.4 31720.2 32162.0 1146.3 1186.4 1215.9 1218.8 1297.6 14293.1 14688.1 14706.3 14719.9 15010.5 374608.0 528612.0 536061.4 539762.0 541525.0 58563.0 58917.0 59310.4 59322.0 59334.0 1394.5 1403.3 1415.9 1422.6 1431.5 31376.2 32260.2 32433.8 32924.2 32975.0 48418.0 49090.0 49120.0 49658.5 49687.5 367378.0 370308.0 371101.0 371532.0 371646.0 34975.3 35801.5 36088.5 36119.1 36337.0 43867.0 44360.8 44788.8 45464.3 46117.0 38325.8 38776.8 38867.2 39229.6 39955.0 37229.3 37941.9 38247.8 38317.8 38483.4 33903.0 38256.8 39069.4 39150.4 39424.4 30618.7 31111.7 31296.5 31319.4 31385.1 24965.0 25266.7 25979.6 26093.6 27269.9 11:26:54 INFO - PROCESS | 18635 | 11:26:54 INFO - PROCESS | 18635 | [#2] jquery.html Cycles:180 Average:27479.65 Median:12115.10 stddev:80924.03 (668.0%) stddev-sans-first:81125.41 11:26:54 INFO - PROCESS | 18635 | Values: 354.7 358.6 359.4 365.1 365.3 17375.7 17476.6 19058.1 19118.3 19240.5 17711.1 18159.7 18241.5 18298.6 18326.6 5206.0 5424.9 5444.9 5448.9 5457.7 5405.3 5465.9 5525.3 5528.4 5534.4 5275.9 5337.7 5352.1 5363.1 5372.1 5279.8 5330.2 5337.3 5366.7 5369.5 4725.3 4778.9 4786.7 4810.0 4834.9 21390.3 21414.4 21574.7 21626.8 21845.8 2384.4 2441.6 2507.6 2740.7 2916.0 13331.1 13502.4 13612.3 13716.8 13881.9 1854.2 1930.4 1953.4 1954.3 2041.5 66647.0 68207.3 68999.7 69199.0 69672.1 9404.4 9418.0 9975.0 10308.8 10675.3 13559.3 13773.9 13783.7 13821.5 13856.9 7877.7 7937.4 7999.8 8041.4 8161.5 7746.7 7890.3 7999.1 8025.0 8037.6 6053.2 6082.4 6142.7 6170.2 6225.5 1790.5 1836.8 1837.7 1841.2 1875.2 915.9 1010.6 1021.3 1055.8 1144.5 17862.4 18170.7 18203.4 18343.6 18924.8 1019.9 1037.7 1041.6 1057.5 1102.9 10216.3 10663.1 10709.0 10728.1 10742.2 472221.0 494035.0 500771.0 503239.0 505330.0 50934.7 59790.4 62085.4 68257.3 70957.3 1060.0 1085.7 1087.4 1098.1 1115.4 16007.8 16291.0 16351.6 16406.4 16818.2 35127.5 36328.6 36354.8 37951.2 38005.2 52751.0 53793.5 54182.0 54388.0 54650.0 8265.9 8298.1 8356.3 8388.9 8476.2 11923.5 12094.5 12617.4 12636.0 12849.3 10261.7 10723.4 11182.9 11334.2 11410.1 10917.2 10993.8 11008.6 11090.8 11484.2 10863.8 11225.5 11555.9 11567.9 11711.1 7775.4 7924.3 8046.6 8084.3 8108.4 10419.3 11240.7 11287.4 11347.0 11355.4 11:26:54 INFO - PROCESS | 18635 | 11:26:54 INFO - PROCESS | 18635 | [#3] mootools.html Cycles:180 Average:5546.21 Median:6628.50 stddev:2862.25 (43.2%) stddev-sans-first:2853.94 11:26:54 INFO - PROCESS | 18635 | Values: 1477.9 1497.3 1664.8 1776.6 1807.6 6942.4 7568.1 7693.0 7916.6 7945.9 7718.9 7745.5 7833.7 7834.3 7844.1 2279.6 2290.4 2308.8 2314.7 2319.3 2269.6 2273.3 2321.9 2325.7 2327.0 2284.2 2290.2 2302.4 2345.4 2351.6 2301.6 2306.2 2307.8 2313.9 2321.6 2232.8 2249.0 2250.9 2252.3 2258.8 7940.0 7949.2 7958.3 7959.3 7965.8 4895.6 5028.3 5036.8 5043.9 5050.6 3115.3 3125.1 3242.3 3267.2 3267.4 996.0 1004.7 1012.8 1031.6 1044.2 10325.7 10486.5 10523.4 10537.5 10542.2 4382.6 4408.3 4480.1 4493.1 4533.8 8940.4 8965.8 8989.9 9021.9 9022.9 5017.0 5026.9 5046.0 5060.6 5065.8 4029.3 4582.3 4594.3 4618.3 4694.4 3691.8 3761.9 3764.5 3790.1 3809.7 1252.0 1255.9 1263.7 1273.4 1298.4 1120.5 1133.0 1143.3 1362.2 1434.1 7247.3 7353.3 7372.3 7562.7 7612.0 450.7 460.4 465.9 473.8 502.7 5887.1 5890.6 5905.8 5915.1 5921.8 9114.5 9336.0 9527.7 9558.4 9589.1 9497.4 9511.6 9527.0 9580.3 9631.7 7044.0 7205.7 7208.7 7218.7 7398.0 7639.8 7719.8 7725.4 7740.7 7750.4 8469.7 8741.8 8812.1 8915.6 8951.1 8838.8 8904.0 8904.6 8944.2 9003.2 6230.3 6722.4 6888.9 7134.0 7148.1 7484.8 7497.3 7506.7 7508.9 7526.5 6604.8 6652.2 6682.5 6715.3 6903.7 6911.1 6926.1 6967.4 6998.5 7091.5 7035.4 7237.6 7336.2 7358.0 7362.5 6659.6 6693.8 6733.3 6739.0 6772.9 6689.5 6782.7 6800.0 6810.0 6830.8 11:26:54 INFO - PROCESS | 18635 | 11:26:54 INFO - PROCESS | 18635 | [#4] prototype.html Cycles:180 Average:5661.54 Median:6470.31 stddev:1746.72 (27.0%) stddev-sans-first:1705.33 11:26:54 INFO - PROCESS | 18635 | Values: 339.4 343.3 349.5 350.1 351.1 6430.9 6493.2 6497.0 6520.4 6521.7 6376.1 6385.7 6476.9 6478.2 6481.4 4877.0 4877.5 4880.7 4880.7 4883.2 4643.1 4711.6 4895.3 4897.1 4899.0 4701.1 4722.7 4778.3 4788.7 4791.7 4774.5 4782.0 4784.0 4790.4 4792.5 4197.8 4201.8 4203.2 4205.0 4229.1 6101.2 6120.1 6158.4 6163.0 6193.8 5601.4 5619.9 5621.6 5625.2 5630.7 6468.7 6713.8 6721.0 6727.5 6732.9 4562.6 4573.9 4575.5 4579.0 4582.9 6865.9 6964.9 7018.0 7022.2 7034.7 4655.3 4657.0 4658.3 4660.6 4663.1 4705.5 4709.0 4720.9 4722.5 4733.2 5547.1 5549.3 5554.3 5554.8 5562.1 6786.3 6801.3 6802.4 6807.2 6808.3 1632.8 1632.8 1667.2 1670.8 1674.4 1070.6 1092.9 1093.2 1102.2 1105.5 6414.1 6464.3 6471.9 6488.2 6515.7 6885.6 6932.4 6965.5 6969.5 6970.7 6409.2 6417.4 6418.6 6426.3 6430.0 3706.1 3750.9 3754.8 3788.7 3805.9 7160.0 7264.9 7283.9 7311.6 7315.8 7200.3 7225.6 7227.1 7232.5 7237.5 7233.5 7260.6 7326.7 7345.3 7373.8 6963.1 6966.1 7015.1 7104.8 7110.1 6930.1 6956.1 6956.4 6969.5 6971.9 7333.5 7347.8 7351.5 7351.9 7352.7 4675.3 4698.0 4699.6 4701.2 4740.2 6849.6 7085.9 7096.0 7098.4 7112.0 6804.5 6860.0 6881.7 6887.3 6894.5 6848.2 6856.5 6862.8 6878.1 6883.0 6756.8 6766.5 6768.8 6782.8 6783.8 6742.6 6848.7 6861.0 6907.6 6941.2 6756.2 6771.1 6778.1 6785.3 6785.6 11:26:54 INFO - PROCESS | 18635 | 11:26:54 INFO - PROCESS | 18635 | [#5] yui.html Cycles:180 Average:14683.61 Median:24687.35 stddev:16761.16 (67.9%) stddev-sans-first:16775.36 11:26:54 INFO - PROCESS | 18635 | Values: 715.4 725.8 737.8 753.1 769.6 14565.8 14730.9 14758.3 14776.7 14801.5 12803.9 13223.7 13501.5 13609.5 13626.3 810.4 813.5 818.5 819.1 821.8 813.5 814.6 814.8 814.9 820.2 851.8 855.6 858.4 858.7 860.7 848.8 851.4 854.4 854.9 858.8 632.1 632.6 633.8 633.9 636.4 13250.6 13322.5 13324.7 13340.3 13374.3 11966.9 12016.0 12022.6 12134.5 12190.5 10358.4 10364.1 10695.9 12075.9 12078.5 4429.9 4454.1 4465.2 4587.4 4602.5 52487.5 53330.7 53389.7 53449.7 53592.7 10405.0 10561.8 10571.9 10689.6 10818.5 18800.2 18855.7 18861.2 19005.1 19009.5 7955.0 7968.1 8116.7 8149.9 8255.3 4686.7 4687.6 4742.2 4770.5 4898.1 3492.5 3519.6 3534.9 3541.8 3545.1 609.5 614.8 615.0 616.6 628.0 646.5 654.9 693.0 723.1 748.6 8878.3 8916.9 8985.8 9002.3 9117.5 650.8 665.8 673.0 737.3 759.9 4159.1 4389.7 4408.2 4427.0 4435.9 55308.7 55517.2 55812.4 55901.0 56023.7 53955.0 55787.0 56351.4 56576.7 56625.0 44787.3 48346.3 50974.2 51293.5 51459.7 9383.8 9473.5 9514.3 9644.8 9672.1 37751.4 37976.0 38403.4 38459.2 39081.4 43803.8 44092.3 47450.0 48184.3 49618.0 11841.2 11954.3 12265.2 12319.9 12369.3 13276.3 13351.3 13424.3 13727.1 14269.4 11817.6 11842.3 11996.2 12164.3 12288.8 12455.0 12672.2 12995.2 13001.0 13006.3 12496.5 12536.8 12564.8 12884.7 12889.3 10479.1 10751.9 10849.5 10873.2 10882.5 10623.9 10625.3 10698.7 10988.5 11152.3 11:26:54 INFO - PROCESS | 18635 | -------- Summary: end -------- 11:26:54 INFO - PROCESS | 18635 | 11:26:54 INFO - TEST-INFO | 18635: exit 0 11:26:54 INFO - TEST-OK | dromaeo_css | took 1109225ms 11:26:54 INFO - TEST-START | kraken 11:26:54 INFO - operating with platform_type : linux_ 11:26:54 INFO - Initialising browser for kraken test... 11:26:54 INFO - TEST-INFO | started process 18871 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4Uw4F9/profile http://localhost:39972/getInfo.html) 11:26:58 INFO - PROCESS | 18871 | 11:26:58 INFO - PROCESS | 18871 | (process:18938): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:26:58 INFO - PROCESS | 18871 | JavaScript error: jar:file:///builds/slave/test-pgo/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 11:26:59 INFO - PROCESS | 18871 | __metrics Screen width/height:1600/1200 11:26:59 INFO - PROCESS | 18871 | colorDepth:24 11:26:59 INFO - PROCESS | 18871 | Browser inner width/height: 1024/697 11:26:59 INFO - PROCESS | 18871 | __metrics 11:27:00 ERROR - PROCESS | 18871 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2881: TypeError: this.tabs is undefined 11:27:00 INFO - TEST-INFO | 18871: exit 0 11:27:00 INFO - Browser initialized. 11:27:00 INFO - Running cycle 1/1 for kraken test... 11:27:00 INFO - TEST-INFO | started process 18989 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4Uw4F9/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:27:02 INFO - PROCESS | 18989 | 11:27:02 INFO - PROCESS | 18989 | (process:19051): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:27:12 INFO - PROCESS | 18989 | RSS: Main: 162619392 11:27:12 INFO - PROCESS | 18989 | 11:27:15 INFO - PROCESS | 18989 | Cycle 1(1): loaded http://localhost:39972/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39972/tests/kraken/driver.html?testName=audio-beat-detection) 11:27:15 INFO - PROCESS | 18989 | RSS: Main: 167534592 11:27:15 INFO - PROCESS | 18989 | 11:27:18 INFO - PROCESS | 18989 | Cycle 1(1): loaded http://localhost:39972/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39972/tests/kraken/driver.html?testName=audio-dft) 11:27:19 INFO - PROCESS | 18989 | RSS: Main: 171429888 11:27:19 INFO - PROCESS | 18989 | 11:27:22 INFO - PROCESS | 18989 | Cycle 1(1): loaded http://localhost:39972/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39972/tests/kraken/driver.html?testName=audio-fft) 11:27:22 INFO - PROCESS | 18989 | RSS: Main: 162177024 11:27:22 INFO - PROCESS | 18989 | 11:27:24 INFO - PROCESS | 18989 | Cycle 1(1): loaded http://localhost:39972/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39972/tests/kraken/driver.html?testName=audio-oscillator) 11:27:25 INFO - PROCESS | 18989 | RSS: Main: 163360768 11:27:25 INFO - PROCESS | 18989 | 11:27:27 INFO - PROCESS | 18989 | Cycle 1(1): loaded http://localhost:39972/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39972/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:27:28 INFO - PROCESS | 18989 | RSS: Main: 163303424 11:27:28 INFO - PROCESS | 18989 | 11:27:31 INFO - PROCESS | 18989 | Cycle 1(1): loaded http://localhost:39972/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39972/tests/kraken/driver.html?testName=imaging-darkroom) 11:27:31 INFO - PROCESS | 18989 | RSS: Main: 163553280 11:27:31 INFO - PROCESS | 18989 | 11:27:35 INFO - PROCESS | 18989 | Cycle 1(1): loaded http://localhost:39972/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39972/tests/kraken/driver.html?testName=imaging-desaturate) 11:27:35 INFO - PROCESS | 18989 | RSS: Main: 164020224 11:27:35 INFO - PROCESS | 18989 | 11:27:38 INFO - PROCESS | 18989 | Cycle 1(1): loaded http://localhost:39972/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39972/tests/kraken/driver.html?testName=json-parse-financial) 11:27:39 INFO - PROCESS | 18989 | RSS: Main: 166002688 11:27:39 INFO - PROCESS | 18989 | 11:27:40 INFO - PROCESS | 18989 | Cycle 1(1): loaded http://localhost:39972/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39972/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:27:41 INFO - PROCESS | 18989 | RSS: Main: 165986304 11:27:41 INFO - PROCESS | 18989 | 11:27:43 INFO - PROCESS | 18989 | Cycle 1(1): loaded http://localhost:39972/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39972/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:27:43 INFO - PROCESS | 18989 | RSS: Main: 165810176 11:27:43 INFO - PROCESS | 18989 | 11:27:45 INFO - PROCESS | 18989 | Cycle 1(1): loaded http://localhost:39972/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39972/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:27:46 INFO - PROCESS | 18989 | RSS: Main: 166244352 11:27:46 INFO - PROCESS | 18989 | 11:27:48 INFO - PROCESS | 18989 | Cycle 1(1): loaded http://localhost:39972/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39972/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:27:49 INFO - PROCESS | 18989 | RSS: Main: 166674432 11:27:49 INFO - PROCESS | 18989 | 11:27:51 INFO - PROCESS | 18989 | Cycle 1(1): loaded http://localhost:39972/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39972/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:27:52 INFO - PROCESS | 18989 | RSS: Main: 166363136 11:27:52 INFO - PROCESS | 18989 | 11:27:54 INFO - PROCESS | 18989 | Cycle 1(1): loaded http://localhost:39972/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39972/tests/kraken/driver.html?testName=ai-astar) 11:27:54 INFO - PROCESS | 18989 | RSS: Main: 168075264 11:27:54 INFO - PROCESS | 18989 | 11:27:54 INFO - PROCESS | 18989 | __start_tp_report 11:27:54 INFO - PROCESS | 18989 | _x_x_mozilla_page_load 11:27:54 INFO - PROCESS | 18989 | _x_x_mozilla_page_load_details 11:27:54 INFO - PROCESS | 18989 | |i|pagename|runs| 11:27:54 INFO - PROCESS | 18989 | |0;ai-astar;111;106;111;112;112;123;110;110;111;108 11:27:54 INFO - PROCESS | 18989 | |1;audio-beat-detection;159;129;163;168;127;169;157;129;167;137 11:27:54 INFO - PROCESS | 18989 | |2;audio-dft;163;164;163;162;163;163;169;171;170;163 11:27:54 INFO - PROCESS | 18989 | |3;audio-fft;75;75;73;79;80;76;73;76;143;74 11:27:54 INFO - PROCESS | 18989 | |4;audio-oscillator;94;95;145;94;94;93;141;94;93;145 11:27:54 INFO - PROCESS | 18989 | |5;imaging-gaussian-blur;118;118;119;118;117;118;118;117;119;117 11:27:54 INFO - PROCESS | 18989 | |6;imaging-darkroom;146;146;147;148;148;147;147;147;147;147 11:27:54 INFO - PROCESS | 18989 | |7;imaging-desaturate;96;96;95;96;96;96;96;96;96;96 11:27:54 INFO - PROCESS | 18989 | |8;json-parse-financial;58;56;58;59;67;58;57;57;55;54 11:27:54 INFO - PROCESS | 18989 | |9;json-stringify-tinderbox;61;62;61;61;61;62;61;60;61;61 11:27:54 INFO - PROCESS | 18989 | |10;stanford-crypto-aes;80;87;79;78;79;78;79;79;79;86 11:27:54 INFO - PROCESS | 18989 | |11;stanford-crypto-ccm;129;120;117;128;118;114;125;110;118;111 11:27:54 INFO - PROCESS | 18989 | |12;stanford-crypto-pbkdf2;136;148;147;145;148;158;142;142;151;135 11:27:54 INFO - PROCESS | 18989 | |13;stanford-crypto-sha256-iterative;68;65;64;69;63;66;63;64;65;64 11:27:54 INFO - PROCESS | 18989 | __end_tp_report 11:27:54 INFO - PROCESS | 18989 | __start_cc_report 11:27:54 INFO - PROCESS | 18989 | _x_x_mozilla_cycle_collect,837 11:27:54 INFO - PROCESS | 18989 | __end_cc_report 11:27:54 INFO - PROCESS | 18989 | __startTimestamp1460053674467__endTimestamp 11:27:54 INFO - PROCESS | 18989 | 11:27:54 INFO - PROCESS | 18989 | ------- Summary: start ------- 11:27:54 INFO - PROCESS | 18989 | Number of tests: 14 11:27:54 INFO - PROCESS | 18989 | 11:27:54 INFO - PROCESS | 18989 | [#0] ai-astar Cycles:10 Average:111.40 Median:111.00 stddev:4.48 (4.0%) stddev-sans-first:4.75 11:27:54 INFO - PROCESS | 18989 | Values: 111.0 106.0 111.0 112.0 112.0 123.0 110.0 110.0 111.0 108.0 11:27:54 INFO - PROCESS | 18989 | 11:27:54 INFO - PROCESS | 18989 | [#1] audio-beat-detection Cycles:10 Average:150.50 Median:161.00 stddev:17.80 (11.1%) stddev-sans-first:18.61 11:27:54 INFO - PROCESS | 18989 | Values: 159.0 129.0 163.0 168.0 127.0 169.0 157.0 129.0 167.0 137.0 11:27:54 INFO - PROCESS | 18989 | 11:27:54 INFO - PROCESS | 18989 | [#2] audio-dft Cycles:10 Average:165.10 Median:163.50 stddev:3.45 (2.1%) stddev-sans-first:3.57 11:27:54 INFO - PROCESS | 18989 | Values: 163.0 164.0 163.0 162.0 163.0 163.0 169.0 171.0 170.0 163.0 11:27:54 INFO - PROCESS | 18989 | 11:27:54 INFO - PROCESS | 18989 | [#3] audio-fft Cycles:10 Average:82.40 Median:75.50 stddev:21.42 (28.4%) stddev-sans-first:22.55 11:27:54 INFO - PROCESS | 18989 | Values: 75.0 75.0 73.0 79.0 80.0 76.0 73.0 76.0 143.0 74.0 11:27:54 INFO - PROCESS | 18989 | 11:27:54 INFO - PROCESS | 18989 | [#4] audio-oscillator Cycles:10 Average:108.80 Median:94.00 stddev:24.09 (25.6%) stddev-sans-first:24.95 11:27:54 INFO - PROCESS | 18989 | Values: 94.0 95.0 145.0 94.0 94.0 93.0 141.0 94.0 93.0 145.0 11:27:54 INFO - PROCESS | 18989 | 11:27:54 INFO - PROCESS | 18989 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 11:27:54 INFO - PROCESS | 18989 | Values: 118.0 118.0 119.0 118.0 117.0 118.0 118.0 117.0 119.0 117.0 11:27:54 INFO - PROCESS | 18989 | 11:27:54 INFO - PROCESS | 18989 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 11:27:54 INFO - PROCESS | 18989 | Values: 146.0 146.0 147.0 148.0 148.0 147.0 147.0 147.0 147.0 147.0 11:27:54 INFO - PROCESS | 18989 | 11:27:54 INFO - PROCESS | 18989 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 11:27:54 INFO - PROCESS | 18989 | Values: 96.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 11:27:54 INFO - PROCESS | 18989 | 11:27:54 INFO - PROCESS | 18989 | [#8] json-parse-financial Cycles:10 Average:57.90 Median:58.00 stddev:3.54 (6.1%) stddev-sans-first:3.76 11:27:54 INFO - PROCESS | 18989 | Values: 58.0 56.0 58.0 59.0 67.0 58.0 57.0 57.0 55.0 54.0 11:27:54 INFO - PROCESS | 18989 | 11:27:54 INFO - PROCESS | 18989 | [#9] json-stringify-tinderbox Cycles:10 Average:61.10 Median:61.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 11:27:54 INFO - PROCESS | 18989 | Values: 61.0 62.0 61.0 61.0 61.0 62.0 61.0 60.0 61.0 61.0 11:27:54 INFO - PROCESS | 18989 | 11:27:54 INFO - PROCESS | 18989 | [#10] stanford-crypto-aes Cycles:10 Average:80.40 Median:79.00 stddev:3.27 (4.1%) stddev-sans-first:3.47 11:27:54 INFO - PROCESS | 18989 | Values: 80.0 87.0 79.0 78.0 79.0 78.0 79.0 79.0 79.0 86.0 11:27:54 INFO - PROCESS | 18989 | 11:27:54 INFO - PROCESS | 18989 | [#11] stanford-crypto-ccm Cycles:10 Average:119.00 Median:119.00 stddev:6.62 (5.6%) stddev-sans-first:5.95 11:27:54 INFO - PROCESS | 18989 | Values: 129.0 120.0 117.0 128.0 118.0 114.0 125.0 110.0 118.0 111.0 11:27:54 INFO - PROCESS | 18989 | 11:27:54 INFO - PROCESS | 18989 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.20 Median:147.50 stddev:6.88 (4.7%) stddev-sans-first:6.44 11:27:54 INFO - PROCESS | 18989 | Values: 136.0 148.0 147.0 145.0 148.0 158.0 142.0 142.0 151.0 135.0 11:27:54 INFO - PROCESS | 18989 | 11:27:54 INFO - PROCESS | 18989 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.10 Median:65.00 stddev:2.02 (3.1%) stddev-sans-first:1.86 11:27:54 INFO - PROCESS | 18989 | Values: 68.0 65.0 64.0 69.0 63.0 66.0 63.0 64.0 65.0 64.0 11:27:54 INFO - PROCESS | 18989 | -------- Summary: end -------- 11:27:54 INFO - PROCESS | 18989 | 11:27:55 INFO - TEST-INFO | 18989: exit 0 11:27:55 INFO - TEST-OK | kraken | took 60440ms 11:27:55 INFO - SUITE-END | took 1169s 11:27:55 INFO - Completed test suite (00:19:29) 11:27:55 INFO - javascript benchmark 11:27:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3097.8141311521313, 3168.762342824288, 3189.4259033373996, 3207.711305982461, 3231.8384080795954, 5420.105682562373, 5430.185472179175, 5432.375276843164, 5451.3871656161555, 5464.26232458618, 5369.355677318717, 5394.757235924383, 5466.508014278714, 5496.972515137419, 5517.172424136382, 4950.6782059166035, 4955.628327875405, 4975.925361119586, 5040.0, 5083.364579427572, 5021.196608542634, 5024.422191447976, 5061.569766569846, 5078.13671675816, 5111.4121875984365, 4850.975745121269, 4912.943717100805, 4915.8525244242555, 4960.727160006199, 5023.120953833083, 4928.383952005999, 4963.6277279204205, 4964.230544265644, 4964.87587810304, 4972.552470277692, 4884.535969082932, 4916.729579873106, 4920.606351491872, 4962.801487940478, 5015.924761128586, 5148.433672296044, 5297.523222909918, 5350.35795704514, 5360.678359298455, 5363.678179309254, 5762.855928601818, 5779.219805326269, 5780.017397042471, 5787.884242315172, 5802.535797136219, 5792.652440853562, 5829.766809327622, 5835.79574714883, 5846.561507886926, 5861.6483011019045, 5460.426655201226, 5493.478119578634, 5511.669299841982, 5528.170774383834, 5552.750126244328, 5849.912251316234, 5852.034414321589, 5860.501857342174, 5880.588358814842, 5892.057270836645, 5656.547476201894, 5669.489745922887, 5672.574556908248, 5692.715364231772, 5738.569607279471, 5729.312482502127, 5747.827565173052, 5748.051571490741, 5750.108733146369, 5753.626014309057, 5633.126865335879, 5661.943380566224, 5697.287839020122, 5734.627249228787, 5767.596268261182, 5720.628159169641, 5798.304203495608, 5815.76736930518, 5847.298324201038, 5857.707114644336, 4295.205387003414, 4296.613304802583, 4350.651947844165, 4354.129174165179, 4375.5405682403525, 3866.4586957825927, 3887.2031233597045, 3891.2217556488818, 3911.765294082364, 3929.174873276587, 5370.489803468664, 5497.422770609109, 5549.889002219933, 5574.777008919679, 5585.357683866326, 5851.882962340729, 5857.502112320415, 5899.793507227227, 5907.763689452459, 5925.229720136441, 5534.584906132056, 5539.0, 5556.361018482846, 5558.527525160407, 5602.607817452821, 4896.216605343128, 4950.3069570260195, 4972.875678108004, 5002.949970500248, 5037.4458809530925, 5967.313758917693, 5967.433093856077, 5967.806438712275, 5982.9401705983255, 6003.549733769984, 5767.769289228468, 5820.563457740602, 5829.766809327749, 5834.15404766315, 5848.268966379118, 5833.416658334133, 5866.472017518444, 5891.528677705859, 5922.526197904243, 6078.3617720138745, 5644.068728659725, 5653.406392328746, 5665.773369065356, 5671.489565939085, 5703.230063941315, 5759.625624334405, 5780.971095144666, 5842.1820945066875, 5854.0, 5868.677222752619, 5647.237622920853, 5700.458456446631, 5735.541156707537, 5741.110127930177, 5755.625884317506, 5648.661080335193, 5662.065759149694, 5674.829755107354, 5677.403872593318, 5725.141228815711, 5581.804636837691, 5582.86042848932, 5592.748326325243, 5594.0, 5619.438056194348, 5637.379888212211, 5659.349174844946, 5708.372079071216, 5762.510186634183, 5794.82615521535, 5603.943960560342, 5653.943460565341, 5654.604177707521, 5659.85850353728, 5667.149927510906], "value": 5350.205531119095, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.2115995286692, 570.1826273101584, 578.6846168837983, 596.6509591888746, 676.8443258050645, 35911.0, 36470.0, 36507.81746091266, 36721.816390918044, 36725.26549469009, 37403.25193496135, 37828.62171378286, 38061.0, 38103.61896381035, 38211.23577528455, 8519.361047921415, 8726.607302671395, 8870.290376769875, 8886.333524985619, 8886.422382545146, 8706.434081784695, 8723.0, 8792.69225577105, 8846.115388461167, 8849.690260840873, 8816.515091669955, 8901.287896968228, 8906.198442140207, 8914.153155450254, 8924.8661270081, 8772.692955746583, 8814.647414103429, 8855.0, 8869.0, 8879.200871921494, 8706.869396959051, 8711.085336039689, 8871.201591856763, 8901.73294801157, 8905.198532132139, 37432.0, 37468.25063498715, 37653.62346376529, 37823.432648510294, 37856.43215351772, 3543.6633519815578, 3549.8580056797696, 3563.6614521620404, 3567.928641427157, 3664.2121943782213, 30381.0, 30680.0, 30831.229219269473, 31269.37461250762, 31299.687003130133, 4127.731697439657, 4196.517400498951, 4244.915101697949, 4291.785410729451, 4379.394832772269, 326023.0, 327144.0, 327764.0, 328401.0, 329118.0, 62911.685441572496, 63126.36873631205, 63309.36690633127, 63321.0, 63620.0, 65973.67013164904, 66879.0, 67212.66393668001, 67285.0, 67371.32628673749, 17195.31218751261, 17466.126693665265, 17469.301227950993, 17538.03540805268, 17606.647867042586, 13062.367204099488, 13092.214467131813, 13119.344032798514, 13119.475220991244, 13130.803037954438, 21404.892975535022, 21475.892620536797, 21488.14047438085, 21599.35201943944, 21602.675959860302, 7868.173841746649, 7898.9210107899335, 8082.474639148437, 8216.26053655162, 8219.068558864634, 1110.1618278199908, 1141.3494308244221, 1163.988360116405, 1178.9919618725867, 1214.5081242096965, 30810.0, 31320.373592528023, 31669.36661266808, 31720.206994825316, 32162.0, 1146.2835727670206, 1186.4008675618757, 1215.8966487848454, 1218.7623413434474, 1297.6496345986532, 14293.142411455347, 14688.118712877262, 14706.33821478036, 14719.92640036793, 15010.549683509513, 374608.0, 528612.0, 536061.4347780482, 539762.0, 541525.0, 58563.0, 58917.0, 59310.406895930486, 59322.0, 59334.0, 1394.4631316942848, 1403.3123769352944, 1415.9362828672733, 1422.6443389152712, 1431.4775107085838, 31376.215594610316, 32260.19349516281, 32433.837830810695, 32924.17689557684, 32975.0, 48418.0, 49090.0, 49120.0, 49658.50341496539, 49687.50312496829, 367378.0, 370308.0, 371101.0, 371532.0, 371646.0, 34975.300493990486, 35801.46297805483, 36088.4586731194, 36119.09702257464, 36337.0, 43867.0, 44360.77819610881, 44788.77605611951, 45464.31803522884, 46117.0, 38325.808370957966, 38776.80611596924, 38867.22265554617, 39229.607703923735, 39955.0, 37229.255414891006, 37941.86174414772, 38247.80876095713, 38317.80841095777, 38483.42274865823, 33903.0, 38256.808715957355, 39069.41395879121, 39150.41274380944, 39424.40863387109, 30618.693813061585, 31111.66662500367, 31296.530552042193, 31319.373612528078, 31385.05844824659, 24965.0, 25266.74733252644, 25979.61030584505, 26093.608595870697, 27269.86365068162], "value": 19836.087397646286, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.7073664227012, 358.6431500656845, 359.39083253884667, 365.0763568172524, 365.3040956976958, 17375.65248695027, 17476.56308592286, 19058.142383592738, 19118.33085841996, 19240.51898702533, 17711.1144442778, 18159.72760408595, 18241.45275641733, 18298.63402731948, 18326.633467330645, 5205.973970130144, 5424.918626220609, 5444.91832622509, 5448.945510544883, 5457.672539647634, 5405.324334458192, 5465.945340546603, 5525.281713377255, 5528.44715528448, 5534.363548191969, 5275.947240527603, 5337.67973921564, 5352.063388906945, 5363.115086010804, 5372.086745253317, 5279.841604751844, 5330.200469929503, 5337.332833395806, 5366.70483123428, 5369.543588794957, 4725.3384526166365, 4778.856634300942, 4786.664933454659, 4809.95190048102, 4834.879128021792, 21390.251341202984, 21414.357569272946, 21574.676379854314, 21626.783732162636, 21845.781542184694, 2384.4277373430427, 2441.6337549367736, 2507.561176794072, 2740.6985231624503, 2915.950257907152, 13331.133476324105, 13502.392392342368, 13612.319384030858, 13716.794248086288, 13881.930590347085, 1854.2304943448453, 1930.3533316339044, 1953.3944477211967, 1954.3355259211794, 2041.4692180033298, 66647.0, 68207.3179268211, 68999.65500172468, 69198.99999999949, 69672.12295139342, 9404.38871473352, 9418.0, 9974.950125249326, 10308.793824123475, 10675.306105103144, 13559.25424101664, 13773.862261377259, 13783.724325513434, 13821.516246931309, 13856.93071534636, 7877.724279650185, 7937.444378893422, 7999.800004999922, 8041.3968952328805, 8161.469504482189, 7746.728864489828, 7890.289873911375, 7999.0801057877925, 8025.03699556057, 8037.598120093972, 6053.182820319289, 6082.422169893853, 6142.662153581507, 6170.197874276405, 6225.533085018642, 1790.4539115569617, 1836.7887692915485, 1837.6692195404955, 1841.208280439424, 1875.2030387085433, 915.9084091590921, 1010.6462738041627, 1021.3055122516612, 1055.7518983038979, 1144.4678224625588, 17862.374816881347, 18170.727439088423, 18203.362882299058, 18343.633127337645, 18924.810751892306, 1019.8623185869961, 1037.7301901505664, 1041.588572513868, 1057.545255540125, 1102.8511150994673, 10216.335938163995, 10663.146948244123, 10708.982646648556, 10728.088112510524, 10742.194335424874, 472221.0, 494035.0, 500771.0, 503239.0, 505330.0, 50934.74532627313, 59790.40209597848, 62085.37914620796, 68257.31742682609, 70957.29042709507, 1060.0, 1085.6742977106837, 1087.3747595132672, 1098.0721290509507, 1115.4088333183427, 16007.759883601988, 16291.0, 16351.59121021984, 16406.425775097814, 16818.243179057215, 35127.487251274666, 36328.63671363358, 36354.818225908704, 37951.240975180895, 38005.23989520139, 52751.0, 53793.462065378844, 54182.0, 54388.0, 54650.0, 8265.917340826514, 8298.087210406971, 8356.289715374018, 8388.874166887623, 8476.23713865755, 11923.463444145207, 12094.516219351128, 12617.369131543202, 12636.0, 12849.293288868828, 10261.692149235534, 10723.356598604109, 11182.944085279521, 11334.206605537533, 11410.14423918193, 10917.23579349438, 10993.780124397308, 11008.559657613605, 11090.778184436427, 11484.19610627248, 10863.841118936874, 11225.494852731483, 11555.88444115548, 11567.88432115668, 11711.063114950954, 7775.416843736629, 7924.286814186751, 8046.597670116588, 8084.272415482635, 8108.3513318933165, 10419.270651054656, 11240.718982025515, 11287.435628218393, 11347.0, 11355.37545434976], "value": 8889.371346071906, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1477.903936244144, 1497.348653335799, 1664.750287456882, 1776.5647416382988, 1807.6294359656272, 6942.4446044316455, 7568.129665088516, 7693.0, 7916.564588947605, 7945.880811787828, 7718.922810771891, 7745.496542724733, 7833.686652533892, 7834.255745704163, 7844.137144914069, 2279.5896738587007, 2290.3815969688176, 2308.7806658367426, 2314.710661167354, 2319.304208737372, 2269.602819506588, 2273.2611901132113, 2321.872297023663, 2325.6744055832196, 2326.9534609307802, 2284.246198754407, 2290.209877592228, 2302.3783578433813, 2345.413646588353, 2351.635496498037, 2301.551197516485, 2306.2158865985643, 2307.7807608277185, 2313.9190128345426, 2321.6053270943894, 2232.7878851509245, 2249.0329158461855, 2250.8762018089, 2252.279270633398, 2258.7515373308925, 7940.047194336659, 7949.205079492062, 7958.283754462126, 7959.323457506119, 7965.761027169194, 4895.6083513318845, 5028.32117664118, 5036.823711170092, 5043.873903152414, 5050.646454748169, 3115.2679120406688, 3125.0624812556143, 3242.270489139925, 3267.232200432896, 3267.3791979524053, 996.0338471682456, 1004.6734811186394, 1012.8126296635146, 1031.582209205273, 1044.216837371971, 10325.690229293134, 10486.475676216234, 10523.421211833345, 10537.473126343652, 10542.156627469783, 4382.649388048949, 4408.338749187647, 4480.081583275421, 4493.078918821634, 4533.750643714561, 8940.418872773249, 8965.775855603531, 8989.865152022725, 9021.909780902239, 9022.909770902339, 5017.0, 5026.949730502722, 5045.974770126126, 5060.5698515625845, 5065.822696205689, 4029.3351596986167, 4582.289745089516, 4594.264917613166, 4618.284165954283, 4694.389729335165, 3691.8338674759702, 3761.9435708464393, 3764.4917936078277, 3790.0903783092413, 3809.657130858236, 1251.9624411267494, 1255.9497620095276, 1263.7219811641423, 1273.4333221716247, 1298.3573131300068, 1120.5461787975883, 1133.0482394788417, 1143.2968724234536, 1362.1622702038374, 1434.103685196752, 7247.311505406978, 7353.338199561958, 7372.299631534996, 7562.697492100255, 7612.048493938258, 450.73181457033013, 460.41297345884266, 465.9138059459011, 473.76548608438355, 502.7310388941972, 5887.087501437284, 5890.558208134407, 5905.793297234576, 5915.053591425351, 5921.822345329647, 9114.498702571289, 9335.953320233355, 9527.666531671497, 9558.378705384128, 9589.089036541518, 9497.43015419077, 9511.57197926095, 9527.047295270417, 9580.281478889112, 9631.71104866855, 7043.964780176067, 7205.675744591506, 7208.71165153388, 7218.675159617725, 7398.0, 7639.770806875803, 7719.768406947801, 7725.420593455626, 7740.729074482366, 7750.418718596241, 8469.703560375357, 8741.825163496822, 8812.074732153287, 8915.598798054232, 8951.149640784115, 8838.779030524289, 8904.0, 8904.599293031959, 8944.239739622206, 9003.189712925869, 6230.314665386713, 6722.428593569602, 6888.896666549906, 7133.964330178316, 7148.142222933281, 7484.775456736306, 7497.325240728361, 7506.662200201114, 7508.887366689395, 7526.5107767994905, 6604.768833090819, 6652.2349929756765, 6682.532222744361, 6715.26132125456, 6903.723851046103, 6911.101556797786, 6926.06498122747, 6967.407770339375, 6998.5101042928545, 7091.468139889425, 7035.381862171832, 7237.565746055254, 7336.229695881855, 7358.0, 7362.484626076123, 6659.633720145439, 6693.765718199839, 6733.293004234681, 6739.0, 6772.93227067723, 6689.498287628545, 6782.660866956534, 6800.0, 6810.0, 6830.795076147723], "value": 4486.806317634459, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.35353152244966, 343.27740107074607, 349.50021469298895, 350.100242377091, 351.0609120602388, 6430.935690643092, 6493.220813502375, 6496.992966090252, 6520.4131628153455, 6521.739130434783, 6376.139221205136, 6385.712642931067, 6476.935230647692, 6478.157839480861, 6481.384268494486, 4876.951230487694, 4877.5366340197625, 4880.658353915227, 4880.731559764212, 4883.218685010399, 4643.094596553673, 4711.575958163765, 4895.31465594817, 4897.118518666656, 4899.044686286175, 4701.106789709961, 4722.669413141081, 4778.307145463906, 4788.664793464459, 4791.712497250176, 4774.498677638832, 4781.976090119527, 4783.995360974182, 4790.377250957354, 4792.472827988919, 4197.790110494463, 4201.831926722927, 4203.159368126357, 4204.978975105136, 4229.090745489703, 6101.206843110367, 6120.112583675342, 6158.353372895871, 6163.0, 6193.845153871144, 5601.439856014406, 5619.93221287954, 5621.606487545832, 5625.184348269478, 5630.718464076821, 6468.708908099147, 6713.832154196135, 6720.966395168041, 6727.529072964894, 6732.93267067328, 4562.5665561771575, 4573.879399547099, 4575.542445755431, 4578.977105114486, 4582.862514124548, 6865.9313406865795, 6964.860702785966, 7017.964910175417, 7022.157341119098, 7034.683439245297, 4655.348251244828, 4657.04530571232, 4658.277966915133, 4660.627149828073, 4663.067386522709, 4705.482396936334, 4708.976455117702, 4720.858374248778, 4722.456917454468, 4733.171694953369, 5547.140193270049, 5549.306336707911, 5554.333479982428, 5554.77780888768, 5562.137868630369, 6786.321367863273, 6801.285864984205, 6802.387785099365, 6807.183138023469, 6808.3191680832515, 1632.7795747574164, 1632.8122265939332, 1667.1914121650989, 1670.8245634208477, 1674.4474323473225, 1070.6252811515908, 1092.8524649172418, 1093.1691914145306, 1102.1568500097433, 1105.4748994227677, 6414.102025716404, 6464.321246269074, 6471.9029214561815, 6488.221413430324, 6515.674216289167, 6885.621290828953, 6932.445404367639, 6965.547239429421, 6969.546979446422, 6970.686319115652, 6409.230892292955, 6417.39034791694, 6418.582792118497, 6426.325235850262, 6429.9678501607195, 3706.1105334720014, 3750.9249815003545, 3754.8122593870744, 3788.734788564774, 3805.8858234253016, 7159.96420017907, 7264.854702906018, 7283.854322913512, 7311.561306321638, 7315.780526584211, 7200.279972002862, 7225.5664660120565, 7227.096612923385, 7232.529885557422, 7237.529560578546, 7233.529820561752, 7260.6006669632625, 7326.743563975236, 7345.338919497164, 7373.8156546086775, 6963.09479767627, 6966.094407726963, 7015.088038554955, 7104.786856394317, 7110.1112360954885, 6930.099087118642, 6956.130483689539, 6956.373926346653, 6969.54697944632, 6971.930280697128, 7333.523320984119, 7347.8163045924275, 7351.485396022227, 7351.889721654073, 7352.669129889275, 4675.275332323496, 4697.9530204698885, 4699.553542413465, 4701.247800351927, 4740.2178640523925, 6849.623270720158, 7085.858282834211, 7096.006559081836, 7098.396636285974, 7112.0, 6804.523683342119, 6860.0, 6881.724731010904, 6887.345702158487, 6894.517383783087, 6848.246692863681, 6856.485763567653, 6862.828429289308, 6878.140232470942, 6882.965585172042, 6756.831079222862, 6766.5263431559315, 6768.796936091925, 6782.830429239309, 6783.830404239933, 6742.595444273359, 6848.657567121723, 6861.0, 6907.585544867324, 6941.167059952838, 6756.223034350916, 6771.052052712525, 6778.118844550177, 6785.2536221016635, 6785.59286442815], "value": 5084.428311586084, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [715.3954908102652, 725.8403151306712, 737.8450525389668, 753.0850017229066, 769.5690413368518, 14565.781513277296, 14730.926345368258, 14758.262086895666, 14776.704465910689, 14801.481948131817, 12803.871961280385, 13223.669408264797, 13501.527446539372, 13609.523666671645, 13626.250556219404, 810.3760104719363, 813.4915677701437, 818.5252553518975, 819.0826274572487, 821.8356328734247, 813.4996976859248, 814.633414963266, 814.7922279818638, 814.9429539932207, 820.1552401026952, 851.8466675998318, 855.5593869157358, 858.3648100405686, 858.6908712863365, 860.6858496648741, 848.7708318753932, 851.3997631669689, 854.3677678517852, 854.9358798090168, 858.7767180533044, 632.1308201223318, 632.6172665537375, 633.7781776378276, 633.9049142628643, 636.360457739973, 13250.602481925558, 13322.467101315935, 13324.733505329936, 13340.266285354302, 13374.264415457146, 11966.880331196751, 12016.0, 12022.63932082039, 12134.514619415213, 12190.47619047619, 10358.43028633425, 10364.067233948905, 10695.946520267427, 12075.879241207564, 12078.456469458895, 4429.867103986886, 4454.109178164348, 4465.196264672358, 4587.380703605004, 4602.493725690171, 52487.47512524864, 53330.73334633302, 53389.733051334886, 53449.73275133599, 53592.73203633957, 10405.0, 10561.841572376266, 10571.894281057244, 10689.625863094754, 10818.513166907507, 18800.153993070344, 18855.717164242546, 18861.245550178115, 19005.14476848545, 19009.524761881064, 7955.0, 7968.12350641429, 8116.675332986614, 8149.877751833727, 8255.339572834158, 4686.671932964728, 4687.578117969331, 4742.170120228946, 4770.499097594772, 4898.118338698997, 3492.511048453219, 3519.560054993126, 3534.8762793302626, 3541.805200713934, 3545.0782796472586, 609.5458883132095, 614.8063360041573, 614.9692515374303, 616.6022915219659, 628.023423576334, 646.5151136647514, 654.9181352330959, 692.9584224946519, 723.0925188888017, 748.5620911766568, 8878.28973682104, 8916.910830891738, 8985.820283594292, 9002.279817614575, 9117.452952822852, 650.8242774450872, 665.7636539028672, 673.0409166937095, 737.2885165814907, 759.9230130350629, 4159.1491786155475, 4389.6927215095275, 4408.228560001987, 4426.955730442654, 4435.889102772457, 55308.72345638246, 55517.16724249139, 55812.441875581535, 55901.0, 56023.71988140115, 53955.0, 55787.0, 56351.43648563544, 56576.717116414155, 56625.0, 44787.328190077176, 48346.27480587794, 50974.221593710274, 51293.48706512887, 51459.742701287, 9383.812323753624, 9473.47895865734, 9514.33399662017, 9644.75888102803, 9672.129508344282, 37751.43372849355, 37976.0, 38403.42394864024, 38459.23081538409, 39081.413778792776, 43803.78098109489, 44092.33861492016, 47450.0, 48184.27723584079, 49618.0, 11841.23032002917, 11954.282743035446, 12265.202761820454, 12319.9384003083, 12369.257844529357, 13276.336183190995, 13351.332433378486, 13424.328783560979, 13727.107737996997, 14269.429222831386, 11817.645470635895, 11842.348670823187, 11996.220245684002, 12164.330961797186, 12288.75422491563, 12455.0, 12672.176308539916, 12995.220286782824, 13001.0, 13006.284654344103, 12496.50628868052, 12536.811947820972, 12564.811527827273, 12884.677883052998, 12889.291088990196, 10479.10927571165, 10751.892481075402, 10849.511771970438, 10873.238873278795, 10882.45587720595, 10623.946880265548, 10625.25623206368, 10698.732531686459, 10988.505517251902, 11152.330860148093], "value": 6720.153495241637, "unit": "score"}], "name": "dromaeo_css", "value": 7245.180522951976, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 111.0, 112.0, 112.0, 123.0, 110.0, 110.0, 111.0, 108.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 129.0, 163.0, 168.0, 127.0, 169.0, 157.0, 129.0, 167.0, 137.0], "value": 150.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 163.0, 162.0, 163.0, 163.0, 169.0, 171.0, 170.0, 163.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 73.0, 79.0, 80.0, 76.0, 73.0, 76.0, 143.0, 74.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 145.0, 94.0, 94.0, 93.0, 141.0, 94.0, 93.0, 145.0], "value": 108.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 119.0, 118.0, 117.0, 118.0, 118.0, 117.0, 119.0, 117.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 148.0, 148.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 56.0, 58.0, 59.0, 67.0, 58.0, 57.0, 57.0, 55.0, 54.0], "value": 57.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 61.0, 61.0, 62.0, 61.0, 60.0, 61.0, 61.0], "value": 61.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 87.0, 79.0, 78.0, 79.0, 78.0, 79.0, 79.0, 79.0, 86.0], "value": 80.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 120.0, 117.0, 128.0, 118.0, 114.0, 125.0, 110.0, 118.0, 111.0], "value": 119.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 148.0, 147.0, 145.0, 148.0, 158.0, 142.0, 142.0, 151.0, 135.0], "value": 145.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 65.0, 64.0, 69.0, 63.0, 66.0, 63.0, 64.0, 65.0, 64.0], "value": 65.1, "unit": "score"}], "name": "kraken", "value": 1507.6999999999998, "alertThreshold": 2.0}]} 11:27:55 INFO - Return code: 0 11:27:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:27:55 ERROR - # TBPL SUCCESS # 11:27:55 INFO - Running post-action listener: _resource_record_post_action 11:27:55 INFO - Running post-run listener: _resource_record_post_run 11:27:56 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 393678848; Read time: 12; Write time: 248780 11:27:56 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 97927168; Read time: 0; Write time: 47656 11:27:56 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 295751680; Read time: 12; Write time: 201124 11:27:56 INFO - Running post-run listener: _upload_blobber_files 11:27:56 INFO - Blob upload gear active. 11:27:56 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 11:27:56 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 11:27:56 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'] 11:27:56 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 11:27:57 INFO - (blobuploader) - INFO - Open directory for files ... 11:27:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:27:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:27:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:27:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:27:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:27:58 INFO - (blobuploader) - INFO - Done attempting. 11:27:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:27:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:27:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:27:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:27:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:27:58 INFO - (blobuploader) - INFO - Done attempting. 11:27:58 INFO - (blobuploader) - INFO - Iteration through files over. 11:27:58 INFO - Return code: 0 11:27:58 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 11:27:58 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 11:27:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9a1e79e14af4ec3c31d0c200bcb3fb2cbe07d1b5a746285d4d812840c309a2d6ac463a331076203b4290bf84d54d11efb85a1b7263d36859c02e3388dd38c5a8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/218a06e5a4755f8ed43c0dd70526ddcbb78e3b7fc48df3c0814205de4975c52259e152ad50fea1b3f3a331955a759b6d3741a5721d25a6027ba5b2051c032c86"} 11:27:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 11:27:58 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 11:27:58 INFO - Contents: 11:27:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9a1e79e14af4ec3c31d0c200bcb3fb2cbe07d1b5a746285d4d812840c309a2d6ac463a331076203b4290bf84d54d11efb85a1b7263d36859c02e3388dd38c5a8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/218a06e5a4755f8ed43c0dd70526ddcbb78e3b7fc48df3c0814205de4975c52259e152ad50fea1b3f3a331955a759b6d3741a5721d25a6027ba5b2051c032c86"} 11:27:58 INFO - Running post-run listener: copy_logs_to_upload_dir 11:27:58 INFO - Copying logs to upload dir... 11:27:58 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 11:27:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.064785 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-04-07 11:27:58.501809) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-07 11:27:58.505087) ========= 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=574dc5aafe09851ec43d388c000001b6-1460052184.843169-905759111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9a1e79e14af4ec3c31d0c200bcb3fb2cbe07d1b5a746285d4d812840c309a2d6ac463a331076203b4290bf84d54d11efb85a1b7263d36859c02e3388dd38c5a8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/218a06e5a4755f8ed43c0dd70526ddcbb78e3b7fc48df3c0814205de4975c52259e152ad50fea1b3f3a331955a759b6d3741a5721d25a6027ba5b2051c032c86"} build_url:https://queue.taskcluster.net/v1/task/Ezcu_2ZaTbuOlhEKrw47fQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011430 build_url: 'https://queue.taskcluster.net/v1/task/Ezcu_2ZaTbuOlhEKrw47fQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9a1e79e14af4ec3c31d0c200bcb3fb2cbe07d1b5a746285d4d812840c309a2d6ac463a331076203b4290bf84d54d11efb85a1b7263d36859c02e3388dd38c5a8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/218a06e5a4755f8ed43c0dd70526ddcbb78e3b7fc48df3c0814205de4975c52259e152ad50fea1b3f3a331955a759b6d3741a5721d25a6027ba5b2051c032c86"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-07 11:27:58.530124) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 11:27:58.530455) ========= 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=574dc5aafe09851ec43d388c000001b6-1460052184.843169-905759111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004491 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 11:27:58.615729) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-07 11:27:58.616048) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-07 11:27:58.616336) ========= ========= Total master_lag: 0.27 =========