builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-067 starttime: 1460458815.94 results: success (0) buildid: 20160412013017 builduid: 31276fbde71249e396ab709650f03d02 revision: 52fd577f808f21db74f8ad98c3cc82a20bae486e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-12 04:00:15.937585) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-12 04:00:15.937967) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-12 04:00:15.938258) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1460455452.253405-1676173409 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005603 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-12 04:00:15.985896) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-12 04:00:15.986162) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-12 04:00:16.046815) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 04:00:16.047134) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1460455452.253405-1676173409 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.029472 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 04:00:16.092832) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-12 04:00:16.093119) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-12 04:00:16.093487) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 04:00:16.093756) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1460455452.253405-1676173409 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-12 04:00:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-04-12 04:00:16 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.185136 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 04:00:16.291042) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 04:00:16.291363) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1460455452.253405-1676173409 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.077857 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 04:00:16.377959) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 04:00:16.378354) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 52fd577f808f21db74f8ad98c3cc82a20bae486e --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/mozilla-inbound --rev 52fd577f808f21db74f8ad98c3cc82a20bae486e --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=e0e61f6f900f4dc42e3e8956000001ad-1460455452.253405-1676173409 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-12 04:00:16,566 truncating revision to first 12 chars 2016-04-12 04:00:16,566 Setting DEBUG logging. 2016-04-12 04:00:16,566 attempt 1/10 2016-04-12 04:00:16,566 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/52fd577f808f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-12 04:00:16,855 unpacking tar archive at: mozilla-inbound-52fd577f808f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.552446 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 04:00:16.942307) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-12 04:00:16.942644) ========= echo 52fd577f808f21db74f8ad98c3cc82a20bae486e in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'52fd577f808f21db74f8ad98c3cc82a20bae486e'] 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=e0e61f6f900f4dc42e3e8956000001ad-1460455452.253405-1676173409 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 52fd577f808f21db74f8ad98c3cc82a20bae486e program finished with exit code 0 elapsedTime=0.004532 script_repo_revision: '52fd577f808f21db74f8ad98c3cc82a20bae486e' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-12 04:00:16.992923) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-12 04:00:16.993249) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-12 04:00:17.002930) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-04-12 04:00:17.003203) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=e0e61f6f900f4dc42e3e8956000001ad-1460455452.253405-1676173409 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:00:17 INFO - MultiFileLogger online at 20160412 04:00:17 in /builds/slave/test-pgo 04:00:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 04:00:17 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 04:00:17 INFO - {'append_to_log': False, 04:00:17 INFO - 'base_work_dir': '/builds/slave/test-pgo', 04:00:17 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 04:00:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 04:00:17 INFO - 'branch': 'Mozilla-Inbound', 04:00:17 INFO - 'buildbot_json_path': 'buildprops.json', 04:00:17 INFO - 'config_files': ('talos/linux_config.py',), 04:00:17 INFO - 'default_actions': ('clobber', 04:00:17 INFO - 'read-buildbot-config', 04:00:17 INFO - 'download-and-extract', 04:00:17 INFO - 'populate-webroot', 04:00:17 INFO - 'create-virtualenv', 04:00:17 INFO - 'install', 04:00:17 INFO - 'run-tests'), 04:00:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:00:17 INFO - 'download_minidump_stackwalk': True, 04:00:17 INFO - 'download_symbols': 'ondemand', 04:00:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:00:17 INFO - 'tooltool.py': '/tools/tooltool.py', 04:00:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:00:17 INFO - '/tools/misc-python/virtualenv.py')}, 04:00:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:00:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:00:17 INFO - 'installer_path': 'installer.exe', 04:00:17 INFO - 'log_level': 'info', 04:00:17 INFO - 'log_name': 'talos', 04:00:17 INFO - 'log_to_console': True, 04:00:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:00:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:00:17 INFO - 'opt_config_files': (), 04:00:17 INFO - 'pip_index': False, 04:00:17 INFO - 'sps_profile': False, 04:00:17 INFO - 'sps_profile_interval': 0, 04:00:17 INFO - 'suite': 'dromaeojs', 04:00:17 INFO - 'system_bits': '32', 04:00:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:00:17 INFO - 'title': 'talos-linux64-ix-067', 04:00:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:00:17 INFO - 'use_talos_json': True, 04:00:17 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 04:00:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:00:17 INFO - 'work_dir': 'build'} 04:00:17 INFO - ##### 04:00:17 INFO - ##### Running clobber step. 04:00:17 INFO - ##### 04:00:17 INFO - Running pre-action listener: _resource_record_pre_action 04:00:17 INFO - Running main action method: clobber 04:00:17 INFO - rmtree: /builds/slave/test-pgo/build 04:00:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 04:00:18 INFO - Running post-action listener: _resource_record_post_action 04:00:18 INFO - ##### 04:00:18 INFO - ##### Running read-buildbot-config step. 04:00:18 INFO - ##### 04:00:18 INFO - Running pre-action listener: _resource_record_pre_action 04:00:18 INFO - Running main action method: read_buildbot_config 04:00:18 INFO - Using buildbot properties: 04:00:18 INFO - { 04:00:18 INFO - "project": "", 04:00:18 INFO - "product": "firefox", 04:00:18 INFO - "script_repo_revision": "production", 04:00:18 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 04:00:18 INFO - "repository": "", 04:00:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 04:00:18 INFO - "buildid": "20160412013017", 04:00:18 INFO - "pgo_build": "True", 04:00:18 INFO - "basedir": "/builds/slave/test-pgo", 04:00:18 INFO - "buildnumber": 868, 04:00:18 INFO - "slavename": "talos-linux64-ix-067", 04:00:18 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:00:18 INFO - "platform": "ubuntu64_hw", 04:00:18 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 04:00:18 INFO - "branch": "mozilla-inbound", 04:00:18 INFO - "repo_path": "integration/mozilla-inbound", 04:00:18 INFO - "revision": "52fd577f808f21db74f8ad98c3cc82a20bae486e", 04:00:18 INFO - "stage_platform": "linux64-pgo", 04:00:18 INFO - "builduid": "31276fbde71249e396ab709650f03d02", 04:00:18 INFO - "slavebuilddir": "test" 04:00:18 INFO - } 04:00:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/bIE4V5U-S9GMExek4Am7hQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 04:00:18 INFO - Running post-action listener: _resource_record_post_action 04:00:18 INFO - ##### 04:00:18 INFO - ##### Running download-and-extract step. 04:00:18 INFO - ##### 04:00:18 INFO - Running pre-action listener: _resource_record_pre_action 04:00:18 INFO - Running main action method: download_and_extract 04:00:18 INFO - mkdir: /builds/slave/test-pgo/build/tests 04:00:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:18 INFO - https://queue.taskcluster.net/v1/task/bIE4V5U-S9GMExek4Am7hQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:00:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bIE4V5U-S9GMExek4Am7hQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:00:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bIE4V5U-S9GMExek4Am7hQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:00:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bIE4V5U-S9GMExek4Am7hQ/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 04:00:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bIE4V5U-S9GMExek4Am7hQ/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 04:00:22 INFO - Downloaded 1361 bytes. 04:00:22 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:00:22 INFO - Using the following test package requirements: 04:00:22 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:00:22 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:00:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:00:22 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:00:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:00:22 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:00:22 INFO - u'jsshell-linux-x86_64.zip'], 04:00:22 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:00:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:00:22 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:00:22 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:00:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:00:22 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:00:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:00:22 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:00:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:00:22 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:00:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:00:22 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:00:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:22 INFO - https://queue.taskcluster.net/v1/task/bIE4V5U-S9GMExek4Am7hQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:00:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bIE4V5U-S9GMExek4Am7hQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:00:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bIE4V5U-S9GMExek4Am7hQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:00:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bIE4V5U-S9GMExek4Am7hQ/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 04:00:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bIE4V5U-S9GMExek4Am7hQ/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 04:00:32 INFO - Downloaded 23764056 bytes. 04:00:32 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'] 04:00:32 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 04:00:33 INFO - Return code: 0 04:00:33 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 04:00:33 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')]} 04:00:33 INFO - https://queue.taskcluster.net/v1/task/bIE4V5U-S9GMExek4Am7hQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:00:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bIE4V5U-S9GMExek4Am7hQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:00:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bIE4V5U-S9GMExek4Am7hQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:00:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bIE4V5U-S9GMExek4Am7hQ/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 04:00:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bIE4V5U-S9GMExek4Am7hQ/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 04:00:37 INFO - Downloaded 23764056 bytes. 04:00:37 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'] 04:00:37 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 04:00:39 INFO - Return code: 0 04:00: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')]} 04:00:39 INFO - https://queue.taskcluster.net/v1/task/bIE4V5U-S9GMExek4Am7hQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:00:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bIE4V5U-S9GMExek4Am7hQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:00:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bIE4V5U-S9GMExek4Am7hQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:00:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bIE4V5U-S9GMExek4Am7hQ/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 04:00:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bIE4V5U-S9GMExek4Am7hQ/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 04:00:40 INFO - Downloaded 10841076 bytes. 04:00:40 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'] 04:00:40 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 04:00:40 INFO - Return code: 0 04:00:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:40 INFO - https://queue.taskcluster.net/v1/task/bIE4V5U-S9GMExek4Am7hQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:00:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bIE4V5U-S9GMExek4Am7hQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:00:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bIE4V5U-S9GMExek4Am7hQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:00:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bIE4V5U-S9GMExek4Am7hQ/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 04:00:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bIE4V5U-S9GMExek4Am7hQ/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 04:00:42 INFO - Downloaded 57838707 bytes. 04:00:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bIE4V5U-S9GMExek4Am7hQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:00:42 INFO - mkdir: /builds/slave/test-pgo/properties 04:00:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 04:00:42 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 04:00:42 INFO - Contents: 04:00:42 INFO - build_url:https://queue.taskcluster.net/v1/task/bIE4V5U-S9GMExek4Am7hQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:00:43 INFO - Running post-action listener: _resource_record_post_action 04:00:43 INFO - Running post-action listener: set_extra_try_arguments 04:00:43 INFO - ##### 04:00:43 INFO - ##### Running populate-webroot step. 04:00:43 INFO - ##### 04:00:43 INFO - Running pre-action listener: _resource_record_pre_action 04:00:43 INFO - Running main action method: populate_webroot 04:00:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:00:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:00:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:00:43 INFO - '--tppagecycles', 04:00:43 INFO - '7'], 04:00:43 INFO - 'tests': ['tsvgm']}}, 04:00:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:00:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:00:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:00:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:00:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:00:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:00:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:43 INFO - 'talos_options': ['--disable-e10s'], 04:00:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:00:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:00:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:43 INFO - 'talos_options': ['--disable-e10s'], 04:00:43 INFO - 'tests': ['damp', 'tps']}, 04:00:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:43 INFO - 'tests': ['damp', 'tps']}, 04:00:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:00:43 INFO - 'tests': ['dromaeo_dom']}, 04:00:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:00:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:00:43 INFO - 'tests': ['a11yr', 04:00:43 INFO - 'ts_paint', 04:00:43 INFO - 'tpaint', 04:00:43 INFO - 'sessionrestore', 04:00:43 INFO - 'sessionrestore_no_auto_restore', 04:00:43 INFO - 'tabpaint']}, 04:00:43 INFO - 'other-e10s': {'tests': ['a11yr', 04:00:43 INFO - 'ts_paint', 04:00:43 INFO - 'tpaint', 04:00:43 INFO - 'sessionrestore', 04:00:43 INFO - 'sessionrestore_no_auto_restore', 04:00:43 INFO - 'tabpaint']}, 04:00:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:00:43 INFO - 'ts_paint', 04:00:43 INFO - 'tpaint', 04:00:43 INFO - 'sessionrestore', 04:00:43 INFO - 'sessionrestore_no_auto_restore', 04:00:43 INFO - 'tabpaint']}, 04:00:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:00:43 INFO - 'ts_paint', 04:00:43 INFO - 'tpaint', 04:00:43 INFO - 'sessionrestore', 04:00:43 INFO - 'sessionrestore_no_auto_restore', 04:00:43 INFO - 'tabpaint']}, 04:00:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:00:43 INFO - 'tests': ['a11yr', 04:00:43 INFO - 'ts_paint', 04:00:43 INFO - 'tpaint', 04:00:43 INFO - 'sessionrestore', 04:00:43 INFO - 'sessionrestore_no_auto_restore', 04:00:43 INFO - 'tabpaint']}, 04:00:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:00:43 INFO - 'tests': ['a11yr', 04:00:43 INFO - 'ts_paint', 04:00:43 INFO - 'tpaint', 04:00:43 INFO - 'sessionrestore', 04:00:43 INFO - 'sessionrestore_no_auto_restore', 04:00:43 INFO - 'tabpaint']}, 04:00:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:00:43 INFO - 'tests': ['tsvgx', 04:00:43 INFO - 'tsvgr_opacity', 04:00:43 INFO - 'tart', 04:00:43 INFO - 'tscrollx', 04:00:43 INFO - 'cart']}, 04:00:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:00:43 INFO - 'tsvgr_opacity', 04:00:43 INFO - 'tart', 04:00:43 INFO - 'tscrollx', 04:00:43 INFO - 'cart']}, 04:00:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:43 INFO - 'talos_options': ['--disable-e10s'], 04:00:43 INFO - 'tests': ['tp5o']}, 04:00:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:43 INFO - 'tests': ['tp5o']}, 04:00:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:43 INFO - 'talos_options': ['--disable-e10s', 04:00:43 INFO - '--xperf_path', 04:00:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:00:43 INFO - 'tests': ['tp5n']}, 04:00:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:43 INFO - 'talos_options': ['--xperf_path', 04:00:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:00:43 INFO - 'tests': ['tp5n']}}, 04:00:43 INFO - 'talos.zip': {'path': '', 04:00:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:00:43 INFO - Running post-action listener: _resource_record_post_action 04:00:43 INFO - ##### 04:00:43 INFO - ##### Running create-virtualenv step. 04:00:43 INFO - ##### 04:00:43 INFO - Running pre-action listener: _resource_record_pre_action 04:00:43 INFO - Running main action method: create_virtualenv 04:00:43 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 04:00: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 04:00:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 04:00:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:00:43 INFO - Using real prefix '/usr' 04:00:43 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 04:00:44 INFO - Installing distribute.............................................................................................................................................................................................done. 04:00:46 INFO - Installing pip.................done. 04:00:46 INFO - Return code: 0 04:00:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 04:00: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')]} 04:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00: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')]} 04:00:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00: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 0x7fb2bbb74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12808d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130f8b0>, '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 0x13107b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1310c60>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1460455452.253405-1676173409', '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 04:00: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 04:00: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 04:00:46 INFO - Using env: {'DISPLAY': ':0', 04:00:46 INFO - 'HOME': '/home/cltbld', 04:00:46 INFO - 'LANG': 'en_US.UTF-8', 04:00:46 INFO - 'LANGUAGE': 'en_US:en', 04:00:46 INFO - 'LOGNAME': 'cltbld', 04:00:46 INFO - 'MAIL': '/var/mail/cltbld', 04:00:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:46 INFO - 'MOZ_NO_REMOTE': '1', 04:00:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:46 INFO - 'NO_EM_RESTART': '1', 04:00:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:00:46 INFO - 'PWD': '/builds/slave/test-pgo', 04:00:46 INFO - 'SHELL': '/bin/bash', 04:00:46 INFO - 'SHLVL': '1', 04:00:46 INFO - 'TERM': 'linux', 04:00:46 INFO - 'TMOUT': '86400', 04:00:46 INFO - 'USER': 'cltbld', 04:00:46 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1460455452.253405-1676173409', 04:00:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:46 INFO - '_': '/tools/buildbot/bin/python'} 04:00:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00: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 04:00:46 INFO - Cleaning up... 04:00:46 INFO - Return code: 0 04:00:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 04:00: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')]} 04:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00: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')]} 04:00:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00: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 0x7fb2bbb74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12808d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130f8b0>, '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 0x13107b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1310c60>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1460455452.253405-1676173409', '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 04:00: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 04:00: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 04:00:46 INFO - Using env: {'DISPLAY': ':0', 04:00:46 INFO - 'HOME': '/home/cltbld', 04:00:46 INFO - 'LANG': 'en_US.UTF-8', 04:00:46 INFO - 'LANGUAGE': 'en_US:en', 04:00:46 INFO - 'LOGNAME': 'cltbld', 04:00:46 INFO - 'MAIL': '/var/mail/cltbld', 04:00:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:46 INFO - 'MOZ_NO_REMOTE': '1', 04:00:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:46 INFO - 'NO_EM_RESTART': '1', 04:00:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:00:46 INFO - 'PWD': '/builds/slave/test-pgo', 04:00:46 INFO - 'SHELL': '/bin/bash', 04:00:46 INFO - 'SHLVL': '1', 04:00:46 INFO - 'TERM': 'linux', 04:00:46 INFO - 'TMOUT': '86400', 04:00:46 INFO - 'USER': 'cltbld', 04:00:46 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1460455452.253405-1676173409', 04:00:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:46 INFO - '_': '/tools/buildbot/bin/python'} 04:00:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:47 INFO - Downloading/unpacking psutil>=0.7.1 04:00:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 04:00:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:00:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:00:49 INFO - Installing collected packages: psutil 04:00:49 INFO - Running setup.py install for psutil 04:00:49 INFO - building 'psutil._psutil_linux' extension 04:00:49 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 04:00:50 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 04:00:50 INFO - building 'psutil._psutil_posix' extension 04:00:50 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 04:00:50 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 04:00:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:00:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:00:50 INFO - Successfully installed psutil 04:00:50 INFO - Cleaning up... 04:00:50 INFO - Return code: 0 04:00:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 04:00:50 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')]} 04:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:50 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')]} 04:00:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:50 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 0x7fb2bbb74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12808d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130f8b0>, '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 0x13107b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1310c60>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1460455452.253405-1676173409', '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 04:00:50 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 04:00:50 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 04:00:50 INFO - Using env: {'DISPLAY': ':0', 04:00:50 INFO - 'HOME': '/home/cltbld', 04:00:50 INFO - 'LANG': 'en_US.UTF-8', 04:00:50 INFO - 'LANGUAGE': 'en_US:en', 04:00:50 INFO - 'LOGNAME': 'cltbld', 04:00:50 INFO - 'MAIL': '/var/mail/cltbld', 04:00:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:50 INFO - 'MOZ_NO_REMOTE': '1', 04:00:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:50 INFO - 'NO_EM_RESTART': '1', 04:00:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:00:50 INFO - 'PWD': '/builds/slave/test-pgo', 04:00:50 INFO - 'SHELL': '/bin/bash', 04:00:50 INFO - 'SHLVL': '1', 04:00:50 INFO - 'TERM': 'linux', 04:00:50 INFO - 'TMOUT': '86400', 04:00:50 INFO - 'USER': 'cltbld', 04:00:50 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1460455452.253405-1676173409', 04:00:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:50 INFO - '_': '/tools/buildbot/bin/python'} 04:00:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:00:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:00:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:00:52 INFO - Installing collected packages: mozsystemmonitor 04:00:52 INFO - Running setup.py install for mozsystemmonitor 04:00:52 INFO - Successfully installed mozsystemmonitor 04:00:52 INFO - Cleaning up... 04:00:52 INFO - Return code: 0 04:00:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 04:00:52 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')]} 04:00:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:52 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')]} 04:00:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:52 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 0x7fb2bbb74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12808d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130f8b0>, '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 0x13107b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1310c60>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1460455452.253405-1676173409', '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 04:00:52 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 04:00:52 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 04:00:52 INFO - Using env: {'DISPLAY': ':0', 04:00:52 INFO - 'HOME': '/home/cltbld', 04:00:52 INFO - 'LANG': 'en_US.UTF-8', 04:00:52 INFO - 'LANGUAGE': 'en_US:en', 04:00:52 INFO - 'LOGNAME': 'cltbld', 04:00:52 INFO - 'MAIL': '/var/mail/cltbld', 04:00:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:52 INFO - 'MOZ_NO_REMOTE': '1', 04:00:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:52 INFO - 'NO_EM_RESTART': '1', 04:00:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:00:52 INFO - 'PWD': '/builds/slave/test-pgo', 04:00:52 INFO - 'SHELL': '/bin/bash', 04:00:52 INFO - 'SHLVL': '1', 04:00:52 INFO - 'TERM': 'linux', 04:00:52 INFO - 'TMOUT': '86400', 04:00:52 INFO - 'USER': 'cltbld', 04:00:52 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1460455452.253405-1676173409', 04:00:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:52 INFO - '_': '/tools/buildbot/bin/python'} 04:00:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:52 INFO - Downloading/unpacking blobuploader==1.2.4 04:00:52 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 04:00:52 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 04:00: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 04:00: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 04:00: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 04:00: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 04:00:54 INFO - Downloading blobuploader-1.2.4.tar.gz 04:00:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:00:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 04:00:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:55 INFO - Downloading docopt-0.6.1.tar.gz 04:00:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 04:00:55 INFO - Installing collected packages: blobuploader, requests, docopt 04:00:55 INFO - Running setup.py install for blobuploader 04:00:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:00:55 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 04:00:55 INFO - Running setup.py install for requests 04:00:56 INFO - Running setup.py install for docopt 04:00:56 INFO - Successfully installed blobuploader requests docopt 04:00:56 INFO - Cleaning up... 04:00:56 INFO - Return code: 0 04:00:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:00:56 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')]} 04:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:56 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')]} 04:00:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:56 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 0x7fb2bbb74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12808d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130f8b0>, '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 0x13107b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1310c60>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1460455452.253405-1676173409', '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 04:00:56 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 04:00:56 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 04:00:56 INFO - Using env: {'DISPLAY': ':0', 04:00:56 INFO - 'HOME': '/home/cltbld', 04:00:56 INFO - 'LANG': 'en_US.UTF-8', 04:00:56 INFO - 'LANGUAGE': 'en_US:en', 04:00:56 INFO - 'LOGNAME': 'cltbld', 04:00:56 INFO - 'MAIL': '/var/mail/cltbld', 04:00:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:56 INFO - 'MOZ_NO_REMOTE': '1', 04:00:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:56 INFO - 'NO_EM_RESTART': '1', 04:00:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:00:56 INFO - 'PWD': '/builds/slave/test-pgo', 04:00:56 INFO - 'SHELL': '/bin/bash', 04:00:56 INFO - 'SHLVL': '1', 04:00:56 INFO - 'TERM': 'linux', 04:00:56 INFO - 'TMOUT': '86400', 04:00:56 INFO - 'USER': 'cltbld', 04:00:56 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1460455452.253405-1676173409', 04:00:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:56 INFO - '_': '/tools/buildbot/bin/python'} 04:00:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:00:56 INFO - Running setup.py (path:/tmp/pip-VI2xFE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:00:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:00:56 INFO - Running setup.py (path:/tmp/pip-fwlLl4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:00:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:00:56 INFO - Running setup.py (path:/tmp/pip-6BvgWb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:00:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:00:56 INFO - Running setup.py (path:/tmp/pip-aPNibv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:00:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:00:56 INFO - Running setup.py (path:/tmp/pip-zGOmsm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:00:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:00:56 INFO - Running setup.py (path:/tmp/pip-quyZea-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:00:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:00:57 INFO - Running setup.py (path:/tmp/pip-URISiq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:00:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:00:57 INFO - Running setup.py (path:/tmp/pip-Swki9w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:00:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:00:57 INFO - Running setup.py (path:/tmp/pip-WpVsID-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:00:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:00:57 INFO - Running setup.py (path:/tmp/pip-n0yZk5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:00:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:00:57 INFO - Running setup.py (path:/tmp/pip-eiio_M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:00:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:00:57 INFO - Running setup.py (path:/tmp/pip-x8vqfp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:00:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:00:57 INFO - Running setup.py (path:/tmp/pip-SJ1nEq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:00:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:00:57 INFO - Running setup.py (path:/tmp/pip-Mz2AUX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:00:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:00:57 INFO - Running setup.py (path:/tmp/pip-DVhPu2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:00:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:00:57 INFO - Running setup.py (path:/tmp/pip-0maKGl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:00:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:00:57 INFO - Running setup.py (path:/tmp/pip-1jJ_Hn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:00:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:00:57 INFO - Running setup.py install for manifestparser 04:00:57 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 04:00:57 INFO - Running setup.py install for mozcrash 04:00:58 INFO - Running setup.py install for mozdebug 04:00:58 INFO - Running setup.py install for mozdevice 04:00:58 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 04:00:58 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 04:00:58 INFO - Running setup.py install for mozfile 04:00:58 INFO - Running setup.py install for mozhttpd 04:00:58 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 04:00:58 INFO - Running setup.py install for mozinfo 04:00:58 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 04:00:58 INFO - Running setup.py install for mozInstall 04:00:58 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 04:00:58 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 04:00:58 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 04:00:58 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 04:00:58 INFO - Running setup.py install for mozleak 04:00:58 INFO - Running setup.py install for mozlog 04:00:58 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 04:00:58 INFO - Running setup.py install for moznetwork 04:00:58 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 04:00:58 INFO - Running setup.py install for mozprocess 04:00:59 INFO - Running setup.py install for mozprofile 04:00:59 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 04:00:59 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 04:00:59 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 04:00:59 INFO - Running setup.py install for mozrunner 04:00:59 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 04:00:59 INFO - Running setup.py install for mozscreenshot 04:00:59 INFO - Running setup.py install for moztest 04:00:59 INFO - Running setup.py install for mozversion 04:00:59 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 04:00:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:00:59 INFO - Cleaning up... 04:00:59 INFO - Return code: 0 04:00:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:00:59 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')]} 04:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:59 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')]} 04:00:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:59 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 0x7fb2bbb74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12808d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130f8b0>, '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 0x13107b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1310c60>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1460455452.253405-1676173409', '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 04:00:59 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 04:00:59 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 04:00:59 INFO - Using env: {'DISPLAY': ':0', 04:00:59 INFO - 'HOME': '/home/cltbld', 04:00:59 INFO - 'LANG': 'en_US.UTF-8', 04:00:59 INFO - 'LANGUAGE': 'en_US:en', 04:00:59 INFO - 'LOGNAME': 'cltbld', 04:00:59 INFO - 'MAIL': '/var/mail/cltbld', 04:00:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:59 INFO - 'MOZ_NO_REMOTE': '1', 04:00:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:59 INFO - 'NO_EM_RESTART': '1', 04:00:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:00:59 INFO - 'PWD': '/builds/slave/test-pgo', 04:00:59 INFO - 'SHELL': '/bin/bash', 04:00:59 INFO - 'SHLVL': '1', 04:00:59 INFO - 'TERM': 'linux', 04:00:59 INFO - 'TMOUT': '86400', 04:00:59 INFO - 'USER': 'cltbld', 04:00:59 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1460455452.253405-1676173409', 04:00:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:59 INFO - '_': '/tools/buildbot/bin/python'} 04:00:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:00:59 INFO - Running setup.py (path:/tmp/pip-stmxMK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:00:59 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)) 04:00:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:00:59 INFO - Running setup.py (path:/tmp/pip-U6OntB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:00:59 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)) 04:00:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:00:59 INFO - Running setup.py (path:/tmp/pip-WKiuT8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:01:00 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)) 04:01:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:01:00 INFO - Running setup.py (path:/tmp/pip-WCOST0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:01:00 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)) 04:01:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:01:00 INFO - Running setup.py (path:/tmp/pip-qV9oY0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:01:00 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)) 04:01:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:01:00 INFO - Running setup.py (path:/tmp/pip-Ak9Cp_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:01:00 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)) 04:01:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:01:00 INFO - Running setup.py (path:/tmp/pip-08CuYO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:01:00 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)) 04:01:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:01:00 INFO - Running setup.py (path:/tmp/pip-2GiFxB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:01:00 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)) 04:01:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:01:00 INFO - Running setup.py (path:/tmp/pip-euRTeF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:01:00 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)) 04:01:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:01:00 INFO - Running setup.py (path:/tmp/pip-22031S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:01:00 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)) 04:01:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:01:00 INFO - Running setup.py (path:/tmp/pip-R7_jtS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:01:00 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)) 04:01:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:01:00 INFO - Running setup.py (path:/tmp/pip-C0Ogm6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:01:00 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)) 04:01:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:01:00 INFO - Running setup.py (path:/tmp/pip-rEOtk9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:01:00 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)) 04:01:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:01:00 INFO - Running setup.py (path:/tmp/pip-oyUDpJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:01:00 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)) 04:01:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:01:00 INFO - Running setup.py (path:/tmp/pip-579ecW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:01:00 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)) 04:01:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:01:00 INFO - Running setup.py (path:/tmp/pip-abqLSf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:01:00 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)) 04:01:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:01:00 INFO - Running setup.py (path:/tmp/pip-P5LR6E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:01:01 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)) 04:01:01 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)) 04:01:01 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)) 04:01:01 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)) 04:01: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 mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 04:01:01 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)) 04:01:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:01:01 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 04:01:01 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 04:01:01 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 04:01:01 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 04:01:01 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 04:01:01 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 04:01:02 INFO - Downloading blessings-1.6.tar.gz 04:01:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 04:01:03 INFO - Installing collected packages: blessings 04:01:03 INFO - Running setup.py install for blessings 04:01:03 INFO - Successfully installed blessings 04:01:03 INFO - Cleaning up... 04:01:03 INFO - Return code: 0 04:01:03 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 04:01:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:01:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:01:03 INFO - Reading from file tmpfile_stdout 04:01:03 INFO - Current package versions: 04:01:03 INFO - argparse == 1.2.1 04:01:03 INFO - blessings == 1.6 04:01:03 INFO - blobuploader == 1.2.4 04:01:03 INFO - docopt == 0.6.1 04:01:03 INFO - manifestparser == 1.1 04:01:03 INFO - mozInstall == 1.12 04:01:03 INFO - mozcrash == 0.17 04:01:03 INFO - mozdebug == 0.1 04:01:03 INFO - mozdevice == 0.48 04:01:03 INFO - mozfile == 1.2 04:01:03 INFO - mozhttpd == 0.7 04:01:03 INFO - mozinfo == 0.9 04:01:03 INFO - mozleak == 0.1 04:01:03 INFO - mozlog == 3.1 04:01:03 INFO - moznetwork == 0.27 04:01:03 INFO - mozprocess == 0.22 04:01:03 INFO - mozprofile == 0.28 04:01:03 INFO - mozrunner == 6.11 04:01:03 INFO - mozscreenshot == 0.1 04:01:03 INFO - mozsystemmonitor == 0.0 04:01:03 INFO - moztest == 0.7 04:01:03 INFO - mozversion == 1.4 04:01:03 INFO - psutil == 3.1.1 04:01:03 INFO - requests == 1.2.3 04:01:03 INFO - wsgiref == 0.1.2 04:01:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:01:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:03 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 0x7fb2bbb74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12808d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130f8b0>, '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 0x13107b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1310c60>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1460455452.253405-1676173409', '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 04:01:03 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 04:01:03 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 04:01:03 INFO - Using env: {'DISPLAY': ':0', 04:01:03 INFO - 'HOME': '/home/cltbld', 04:01:03 INFO - 'LANG': 'en_US.UTF-8', 04:01:03 INFO - 'LANGUAGE': 'en_US:en', 04:01:03 INFO - 'LOGNAME': 'cltbld', 04:01:03 INFO - 'MAIL': '/var/mail/cltbld', 04:01:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:03 INFO - 'MOZ_NO_REMOTE': '1', 04:01:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:03 INFO - 'NO_EM_RESTART': '1', 04:01:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:01:03 INFO - 'PWD': '/builds/slave/test-pgo', 04:01:03 INFO - 'SHELL': '/bin/bash', 04:01:03 INFO - 'SHLVL': '1', 04:01:03 INFO - 'TERM': 'linux', 04:01:03 INFO - 'TMOUT': '86400', 04:01:03 INFO - 'USER': 'cltbld', 04:01:03 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1460455452.253405-1676173409', 04:01:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:03 INFO - '_': '/tools/buildbot/bin/python'} 04:01:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:03 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)) 04:01:03 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)) 04:01:03 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)) 04:01:03 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)) 04:01:03 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)) 04:01:03 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)) 04:01:03 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)) 04:01:03 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)) 04:01:03 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)) 04:01:03 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)) 04:01:03 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)) 04:01:03 INFO - Cleaning up... 04:01:03 INFO - Return code: 0 04:01:03 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 04:01:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:03 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 0x7fb2bbb74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12808d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130f8b0>, '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 0x13107b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1310c60>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1460455452.253405-1676173409', '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 04:01:03 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 04:01:03 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 04:01:03 INFO - Using env: {'DISPLAY': ':0', 04:01:03 INFO - 'HOME': '/home/cltbld', 04:01:03 INFO - 'LANG': 'en_US.UTF-8', 04:01:03 INFO - 'LANGUAGE': 'en_US:en', 04:01:03 INFO - 'LOGNAME': 'cltbld', 04:01:03 INFO - 'MAIL': '/var/mail/cltbld', 04:01:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:03 INFO - 'MOZ_NO_REMOTE': '1', 04:01:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:03 INFO - 'NO_EM_RESTART': '1', 04:01:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:01:03 INFO - 'PWD': '/builds/slave/test-pgo', 04:01:03 INFO - 'SHELL': '/bin/bash', 04:01:03 INFO - 'SHLVL': '1', 04:01:03 INFO - 'TERM': 'linux', 04:01:03 INFO - 'TMOUT': '86400', 04:01:03 INFO - 'USER': 'cltbld', 04:01:03 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1460455452.253405-1676173409', 04:01:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:03 INFO - '_': '/tools/buildbot/bin/python'} 04:01:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:03 INFO - Downloading/unpacking jsonschema 04:01:03 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 04:01:03 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 04:01:03 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 04:01:03 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 04:01:03 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 04:01:03 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 04:01:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:01:05 INFO - Downloading/unpacking functools32 (from jsonschema) 04:01:05 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 04:01:05 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 04:01:05 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 04:01:05 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 04:01:05 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 04:01:05 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 04:01:05 INFO - Downloading functools32-3.2.3-2.tar.gz 04:01:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 04:01:05 INFO - warning: no files found matching '*.txt' 04:01:05 INFO - no previously-included directories found matching 'build' 04:01:05 INFO - no previously-included directories found matching 'dist' 04:01:05 INFO - no previously-included directories found matching '.git*' 04:01:05 INFO - Installing collected packages: jsonschema, functools32 04:01:06 INFO - Running setup.py install for functools32 04:01:06 INFO - warning: no files found matching '*.txt' 04:01:06 INFO - no previously-included directories found matching 'build' 04:01:06 INFO - no previously-included directories found matching 'dist' 04:01:06 INFO - no previously-included directories found matching '.git*' 04:01:06 INFO - Successfully installed jsonschema functools32 04:01:06 INFO - Cleaning up... 04:01:06 INFO - Return code: 0 04:01:06 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 04:01:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:06 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 0x7fb2bbb74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12808d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130f8b0>, '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 0x13107b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1310c60>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1460455452.253405-1676173409', '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 04:01:06 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 04:01:06 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 04:01:06 INFO - Using env: {'DISPLAY': ':0', 04:01:06 INFO - 'HOME': '/home/cltbld', 04:01:06 INFO - 'LANG': 'en_US.UTF-8', 04:01:06 INFO - 'LANGUAGE': 'en_US:en', 04:01:06 INFO - 'LOGNAME': 'cltbld', 04:01:06 INFO - 'MAIL': '/var/mail/cltbld', 04:01:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:06 INFO - 'MOZ_NO_REMOTE': '1', 04:01:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:06 INFO - 'NO_EM_RESTART': '1', 04:01:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:01:06 INFO - 'PWD': '/builds/slave/test-pgo', 04:01:06 INFO - 'SHELL': '/bin/bash', 04:01:06 INFO - 'SHLVL': '1', 04:01:06 INFO - 'TERM': 'linux', 04:01:06 INFO - 'TMOUT': '86400', 04:01:06 INFO - 'USER': 'cltbld', 04:01:06 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1460455452.253405-1676173409', 04:01:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:06 INFO - '_': '/tools/buildbot/bin/python'} 04:01:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:06 INFO - Downloading/unpacking flake8 04:01: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 04:01: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 04:01: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 04:01: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 04:01: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 04:01: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 04:01:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:01:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:01:08 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 04:01:08 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 04:01:08 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 04:01:08 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 04:01:08 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 04:01:08 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 04:01:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:01:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:01:08 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 04:01:08 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 04:01:08 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 04:01:08 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 04:01:08 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 04:01:08 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 04:01:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:01:08 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 04:01:08 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 04:01:08 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 04:01:08 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 04:01:08 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 04:01:08 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 04:01:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 04:01:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:01:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:01:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:01:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:01:08 INFO - no previously-included directories found matching 'docs/_build' 04:01:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:01:09 INFO - Running setup.py install for pep8 04:01:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:01:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:01:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:01:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:01:09 INFO - no previously-included directories found matching 'docs/_build' 04:01:09 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 04:01:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:01:09 INFO - Cleaning up... 04:01:09 INFO - Return code: 0 04:01:09 INFO - Running post-action listener: _resource_record_post_action 04:01:09 INFO - Running post-action listener: _start_resource_monitoring 04:01:09 INFO - Starting resource monitoring. 04:01:09 INFO - ##### 04:01:09 INFO - ##### Running install step. 04:01:09 INFO - ##### 04:01:09 INFO - Running pre-action listener: _resource_record_pre_action 04:01:09 INFO - Running main action method: install 04:01:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:01:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:01:09 INFO - Reading from file tmpfile_stdout 04:01:09 INFO - Detecting whether we're running mozinstall >=1.0... 04:01:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 04:01:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 04:01:09 INFO - Reading from file tmpfile_stdout 04:01:09 INFO - Output received: 04:01:09 INFO - Usage: mozinstall [options] installer 04:01:09 INFO - Options: 04:01:09 INFO - -h, --help show this help message and exit 04:01:09 INFO - -d DEST, --destination=DEST 04:01:09 INFO - Directory to install application into. [default: 04:01:09 INFO - "/builds/slave/test-pgo"] 04:01:09 INFO - --app=APP Application being installed. [default: firefox] 04:01:09 INFO - mkdir: /builds/slave/test-pgo/build/application 04:01:09 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'] 04:01:09 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 04:01:25 INFO - Reading from file tmpfile_stdout 04:01:26 INFO - Output received: 04:01:26 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 04:01:26 INFO - Running post-action listener: _resource_record_post_action 04:01:26 INFO - ##### 04:01:26 INFO - ##### Running run-tests step. 04:01:26 INFO - ##### 04:01:26 INFO - Running pre-action listener: _resource_record_pre_action 04:01:26 INFO - Running main action method: run_tests 04:01:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 04:01:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 04:01:26 INFO - Python 2.7.3 04:01:26 INFO - Return code: 0 04:01:26 INFO - grabbing minidump binary from tooltool 04:01:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:26 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 0x130f8b0>, '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 0x13107b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1310c60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 04:01:26 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 04:01:26 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 04:01:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:01:26 INFO - Return code: 0 04:01:26 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 04:01:26 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 04:01:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 04:01:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 04:01:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 04:01:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 04:01:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 04:01:27 INFO - Return code: 0 04:01:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bIE4V5U-S9GMExek4Am7hQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 04:01:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bIE4V5U-S9GMExek4Am7hQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 04:01:27 INFO - Using env: {'DISPLAY': ':0', 04:01:27 INFO - 'HOME': '/home/cltbld', 04:01:27 INFO - 'LANG': 'en_US.UTF-8', 04:01:27 INFO - 'LANGUAGE': 'en_US:en', 04:01:27 INFO - 'LOGNAME': 'cltbld', 04:01:27 INFO - 'MAIL': '/var/mail/cltbld', 04:01:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:01:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 04:01:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:27 INFO - 'MOZ_NO_REMOTE': '1', 04:01:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:01:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:27 INFO - 'NO_EM_RESTART': '1', 04:01:27 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:01:27 INFO - 'PWD': '/builds/slave/test-pgo', 04:01:27 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 04:01:27 INFO - 'SHELL': '/bin/bash', 04:01:27 INFO - 'SHLVL': '1', 04:01:27 INFO - 'TERM': 'linux', 04:01:27 INFO - 'TMOUT': '86400', 04:01:27 INFO - 'USER': 'cltbld', 04:01:27 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1460455452.253405-1676173409', 04:01:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:27 INFO - '_': '/tools/buildbot/bin/python'} 04:01:27 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bIE4V5U-S9GMExek4Am7hQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:01:27 INFO - mozversion application_buildid: 20160412013017 04:01:27 INFO - mozversion application_changeset: 52fd577f808f21db74f8ad98c3cc82a20bae486e 04:01:27 INFO - mozversion application_display_name: Nightly 04:01:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:01:27 INFO - mozversion application_name: Firefox 04:01:27 INFO - mozversion application_remotingname: firefox 04:01:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:01:27 INFO - mozversion application_vendor: Mozilla 04:01:27 INFO - mozversion application_version: 48.0a1 04:01:27 INFO - mozversion platform_buildid: 20160412013017 04:01:27 INFO - mozversion platform_changeset: 52fd577f808f21db74f8ad98c3cc82a20bae486e 04:01:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:01:27 INFO - mozversion platform_version: 48.0a1 04:01:27 INFO - using testdate: 1460458887 04:01:27 INFO - actual date: 1460458887 04:01:27 INFO - starting webserver on 'localhost:38207' 04:01:27 INFO - SUITE-START | Running 2 tests 04:01:27 INFO - TEST-START | dromaeo_css 04:01:27 INFO - operating with platform_type : linux_ 04:01:27 INFO - Initialising browser for dromaeo_css test... 04:01:27 INFO - TEST-INFO | started process 3297 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpI4_YuR/profile http://localhost:38207/getInfo.html) 04:01:31 INFO - PROCESS | 3297 | __metrics Screen width/height:1600/1200 04:01:31 INFO - PROCESS | 3297 | colorDepth:24 04:01:31 INFO - PROCESS | 3297 | Browser inner width/height: 1024/697 04:01:31 INFO - PROCESS | 3297 | __metrics 04:01:32 ERROR - PROCESS | 3297 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:01:33 INFO - TEST-INFO | 3297: exit 0 04:01:33 INFO - Browser initialized. 04:01:33 INFO - Running cycle 1/1 for dromaeo_css test... 04:01:33 INFO - TEST-INFO | started process 3378 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpI4_YuR/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:01:45 INFO - PROCESS | 3378 | RSS: Main: 152592384 04:01:45 INFO - PROCESS | 3378 | 04:02:36 INFO - PROCESS | 3378 | 1460458956570 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] 04:04:44 INFO - PROCESS | 3378 | Cycle 1(1): loaded http://localhost:38207/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38207/tests/dromaeo/cssquery-ext.html) 04:04:45 INFO - PROCESS | 3378 | RSS: Main: 241328128 04:04:45 INFO - PROCESS | 3378 | 04:07:47 INFO - PROCESS | 3378 | Cycle 1(1): loaded http://localhost:38207/tests/dromaeo/cssquery-ext.html (next: http://localhost:38207/tests/dromaeo/cssquery-jquery.html) 04:07:48 INFO - PROCESS | 3378 | RSS: Main: 240910336 04:07:48 INFO - PROCESS | 3378 | 04:10:49 INFO - PROCESS | 3378 | Cycle 1(1): loaded http://localhost:38207/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38207/tests/dromaeo/cssquery-mootools.html) 04:10:50 INFO - PROCESS | 3378 | RSS: Main: 235704320 04:10:50 INFO - PROCESS | 3378 | 04:13:52 INFO - PROCESS | 3378 | Cycle 1(1): loaded http://localhost:38207/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38207/tests/dromaeo/cssquery-prototype.html) 04:13:53 INFO - PROCESS | 3378 | RSS: Main: 212033536 04:13:53 INFO - PROCESS | 3378 | 04:16:55 INFO - PROCESS | 3378 | Cycle 1(1): loaded http://localhost:38207/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38207/tests/dromaeo/cssquery-yui.html) 04:16:56 INFO - PROCESS | 3378 | RSS: Main: 230260736 04:16:56 INFO - PROCESS | 3378 | 04:19:58 INFO - PROCESS | 3378 | Cycle 1(1): loaded http://localhost:38207/tests/dromaeo/cssquery-yui.html (next: http://localhost:38207/tests/dromaeo/cssquery-dojo.html) 04:19:59 INFO - PROCESS | 3378 | RSS: Main: 277704704 04:19:59 INFO - PROCESS | 3378 | 04:19:59 INFO - PROCESS | 3378 | __start_tp_report 04:19:59 INFO - PROCESS | 3378 | _x_x_mozilla_page_load 04:19:59 INFO - PROCESS | 3378 | _x_x_mozilla_page_load_details 04:19:59 INFO - PROCESS | 3378 | |i|pagename|runs| 04:19:59 INFO - PROCESS | 3378 | |0;dojo.html;3139.8273094979772;3172.9206769830766;3205.871765129395;3208.1017315151767;3234.2237862912903;5407.810726624564;5415.83752487425;5417.593680473966;5456.290682211317;5506.917396239055;5414.3232095988005;5431.83704488865;5450.427705090968;5475.698836563987;5503.449655034495;4814.879628009293;4860.927086093711;4876.585490233334;4889.119958407486;5074.162763144095;4966.701997880121;4992.550670439659;5030.11972904742;5034.723090230036;5042.445331013586;4808.3989501312335;4831.637627177975;4866.78099485524;4939.728314942677;4997.175466048097;4884.877878053077;4898.951010489921;4910.533499317559;4924.212126059849;4941.184704523749;4858.344123543347;4870.342503761982;4891.951080489185;4901.485344038896;4921.458639549646;5326.174442961308;5364.892702145935;5370;5422.8915421691345;5423.159410291411;5755.251817263771;5780.9710951445395;5786.7395967181155;5788.04497257952;5792.507636850873;5633.042382794934;5737.684427356494;5824.097264923944;5824.621399609012;5831.475167234927;5454.699991500466;5454.91817622736;5456.454354564551;5457.863553411157;5495.203195536625;5959.791407300723;5968.1644569760265;5970.373110823388;5972.8805423892145;5975.4024597540765;5555.111182210827;5643.915341269884;5711.371749107595;5724.713764311768;5731.570132240098;5803.680797556175;5831.620944638585;5835.44563266489;5836.212111364912;5848.298204215522;5762.2509073820975;5765.221695071195;5781.4218578141845;5791.073428251544;5807.912881306784;5657.971710141423;5752.07966725322;5809.331926828384;5844.386339434298;5851.736671849777;4324.0919406924895;4344.630706389929;4347.152305300436;4357.346398040319;4393.340998850198;3903.843846246175;3910.237503686754;3918.0204948762807;3938.78336691479;3962.7226094173707;5270.789168433296;5307.761150748225;5368.141097424394;5375.838724838261;5468.644538105011;5695.943040569624;5700.25896633435;5723.112917497794;5723.456271654186;5726.3700992890745;5383.246345511631;5390.0836857734275;5402.594805389612;5402.648827826179;5433.510984011458;4717.646176536773;4852.51474852519;4900;4909.337239472626;4924.236743304722;5986.2517185351835;5990.580659353891;6003.609765365237;6010.939890601126;6027.7890273841085;5768.423157684198;5771.480566748929;5772.163036359789;5786.247787787729;5788.971055144697;5825.883482330245;5925.940740592711;6008.669523176267;6075.635461872302;6088.939110608837;5604.411536788742;5636.351819540641;5649.435056494318;5655.3213614364895;5665.801696940587;5711.485966263056;5744.942550574608;5751.798687045934;5753.165790960204;5756.395578464369;5521;5685.403032681675;5722.484976352148;5769.798057067983;5776.942230577641;5652.7738890443925;5661.943380566307;5667.121596152603;5668.26312579362;5668.574856885833;5397.190421436816;5572.749226284745;5591.356993945748;5591.692456914909;5596.86007849807;5723.542116630576;5775.018246897954;5779.335376431764;5788.160716695971;5826.213461182686;5556.998182290263;5569.805056822992;5586.916196257141;5587.8882422352135;5633.492985631313 04:19:59 INFO - PROCESS | 3378 | |1;ext.html;644.3202421445374;646.1406329581657;648.3063122458968;659.97030133644;665.7270519087173;36035.2792944141;37741;37776.43335349965;37864.810675946654;37868;42491;43202.56797432025;43367.34948975768;43386.7830660847;43404.78297608507;8657.177568131017;8850.468971861677;8855.512946787923;8873.73378798637;8884.289256859436;8618.396712230146;8746.475211487332;8751.562421878913;8753.47479151253;8756.430831995931;8726.781830454225;8793.736187914374;8795.284919440712;8804.295656347509;8815.867761983576;8703.695370662028;8742.344324175649;8765.649374025032;8774.341924355667;8776.868346974801;8728.43265187767;8747.300215982707;8843.336749743796;8844.46933184011;8851.867221991612;38215.23569528622;38827.22345553101;39143.21713565713;39279;39398.40902386467;3404;3526.5944416392185;4014.0566966762785;4170.311898536738;4232.217039847638;31228.843855780804;31294.687053129404;31321.216969575715;31414.685853141404;31637;4215.43091682622;4243.151369726067;4303.935440968388;4372.016296333331;4373.650107991353;282207;283338;283898.3855887946;284663;284800;54353.456465434836;54383.280835958045;54846.451535484935;54849.177262341094;54869.45130548723;49582;55866.72066639722;56358.43641563614;57517;57984;14276.357563909649;14438.494652687315;14495.927520362542;14510.637234069021;14512.04087448181;11227.943860280646;11350.262232954832;11504;11504.252223605607;11505.079593632488;13502.189868607915;13982.370793314325;14961.775573366409;15308.693826123415;15510.534683959499;6056.969715151484;6170.784022559279;6205.28639206488;6289.339619339995;6300.716467758962;980.3774603127066;1070.6787963610886;1112.7496313329436;1147.208426185929;1163.4822503985815;31110.377792444477;31311.686883131333;31354.52968205479;31516.36967260642;31616.209594759854;1127.6617014895498;1133.5069244878505;1167.497975870384;1168.9298642081503;1240.5499139200008;15993.200339983186;16582.75125873089;16629.916850415913;16665.41895621524;16886.40897568579;387158.34837342234;390161;391558;391820;392189;53100;53877;54017;54056.72971635117;54128;1214.2532342609231;1310.9803352949714;1352.4184600621827;1368.939745682761;1444.83384410792;27521.587176192774;28287.43425131527;28783;28833.711662883103;29086.27284317824;37770.62229377781;38152.809235953646;38254.808725956194;38311;38364.23271534498;270176;272035;272608;273290;273748;32913.34173316472;41497;42069.57930420656;42626.78686606547;43045.569544304155;42820.78589607032;43007.78496107499;43280.56719432891;43771.56228437675;43862.78068609637;36458.45312320264;36675.633243667224;37152.256954861296;37394.43908341323;37733.622663773014;36200.63799362078;36506.63493365139;36559.45160822643;37026.444603330434;37084.072898177765;36546.451803222444;37018.25963480769;37253.25493490169;37689.81155094207;38200.426993595676;32025;33287;33295.66704332926;33382.66617333796;33489.16277092995;26053.739462605132;26083.217503474927;26508.469830602895;26544.203673889813;26816.865915670296 04:19:59 INFO - PROCESS | 3378 | |2;jquery.html;403.151366373783;403.61253196930954;405.4364433437522;406.51421551246256;415.9563245859185;13575.660608484794;16841.326346946124;17514.386996455127;17834.10829458527;17850.196741146647;17520.123993800324;17888.37390691326;18555.165017574207;19389.515262118417;19454.708179377285;5580.497755202041;5693.146028095777;5837.970810145965;5846.795362162326;5856.707164641751;3909.5113110861143;5548.833534993957;5716.399778023289;6149.877002459948;6510.283868774431;6373.235211774593;6456.031595260702;6456.579552498443;6476.870462590746;6486.4162225399705;6275.811725648215;6360.173177486943;6444.387783160616;6458.451031662315;6478.676066196671;5516.345096471083;5683.318001839764;5704.80033198836;5712.343080545749;5715.542756579505;22623.321300361014;22852.54294914109;22856.77143228563;23040.65439018416;23086.191983280503;2327.4065113395977;2338.6024375856146;2399.6040653292184;2688.5295073362086;2843.4170994945985;13073.673158171121;13792.93103534486;14139;14239.430422783076;14637.92681036588;1944.0862794486568;1978.3768113044346;1981.4154824326858;2021.3228568429595;2097.6643737002005;79315.20684793194;80066;80932.19067809306;81366;82048.58975705144;10356.326838755456;10395.428251446243;10668.199885008655;10715;10791.082757965503;13190.73618527624;13787.724245515034;15195.544133676007;15235.314410851539;15245.6188595286;7723.729669461542;7947.841043179104;7956.880646790303;8075.596220188967;8143.063547692092;7311.341979221896;7317.341439270491;7460.85078298431;7482.625868706543;7562.659680314399;6295.874082518324;6356.586821856657;6475.222973243147;6535.117759102461;6570.408663220238;1894.4316704988448;1895.6966885298561;1927.6722957097327;1935.7386752788193;1939.1370839976075;914.085914085914;1024.472396715692;1030.3611760708259;1105.3036586950332;1148.529103067755;19384.418467445717;19582.706259405837;19778.30775922836;19888.403347899588;20015;1019.4647809899714;1053.4364115198332;1053.4364115198332;1062.1131355318241;1091.3397394576325;10708.1433485321;11325.716857078474;11400.543978240778;11452.3701196435;11509.884901150881;501313;502628;503731;515368;517688;80402.19597804065;82020;82577.17422825815;83500;84086;599.868029033612;761.3300295739824;988.7280997725683;1074.2909679611419;1076.252004856617;16369.87191665076;16623.3350665972;16730.16349182512;16965.321387144868;17110.572235694206;23302.417439564146;33036.1740956478;33274.33451331008;34645.333227460345;35143.297134056666;38150;40016.59983400129;43605.56394436015;44901.55098448974;45581.08837823159;7430.219826918095;8638.611262493077;8790.340724445565;8835.20483156519;8876.28989680811;12950.287734174712;13010;13051.412686429323;13111.868881311446;13146.737065258832;11775;11816.113791465503;11881.168318217642;12020.519179232733;12090.939545302217;10963.342199468058;11542.769144616892;11631.302121872715;11707.590234341757;11938.22401543897;11336.376499292619;11596.88403115958;11670.94164529172;12135.514579416724;12341.321227332583;7222.494425390172;8658.740237792876;8807.955960220157;8975.192232699088;9075.636974520945;11509;11762.176647634584;11787.587434439753;12226.75546489083;12249.755004900031 04:19:59 INFO - PROCESS | 3378 | |3;mootools.html;1357.952471663492;1496.5136330692524;1536.0169491525426;1667.9082650454227;1800.7388928605353;8190.54951977641;8506.064332923374;8508.78728031798;8509.106543812903;8553.358498112651;8260.215279548449;8340.874886876687;8404.07555168931;8420.821085048097;8426.494410335385;2035.8065983731522;2310.445493081665;2373.537160253751;2385.522895420914;2399.5320912422085;2393.5811233034237;2420.044082587377;2422.1159276863905;2426.0902161689364;2427.3082171581104;2374.0622454130694;2404.350825277174;2407.735149133594;2407.879606019701;2417.685700858886;2043.4789128772143;2319.895604697793;2383.07060246504;2385.3798012516695;2392.2823153054014;2247.224707475918;2268.0814270220585;2274.20402858998;2275.16956310947;2278.054607337953;8206.384521160877;8323.542205178714;8341.165883411672;8344.582770861492;8347.248747612683;5096.159133742965;5191.299174611417;5215.895682086375;5228.398734145546;5319.148936170194;3241.6758324167395;3369.6630336966355;3395.3548825723033;3470.1498132957336;3539.823008849547;1148.707079694681;1186.9228500147549;1188.881111888813;1204.403820109043;1206.221986818497;11366.261193022427;11450.312981221154;11461.828072578917;11476.368799716012;11500.309981401058;4317;4437.112577484516;4598.3102534620075;4600.769961501912;4607.976960115178;9305.302102342352;9328.486933218603;9358.57886395114;9369;9369.531523423802;4586.380838586748;5261.105612045885;5266.97366513165;5294.814681486129;5307.177387504943;4839;4945.9258111128365;4950.430700469492;4969.130402179604;4998.975005125024;3724.5902950675404;3763.49192858966;3800.7837492002295;3835.6931445484292;3880.0881792778673;1135.392564977733;1142.8228624563205;1158.1834806461425;1158.9942050289694;1191.4162060590422;1354.7290541891662;1372;1395.141987677571;1428.4500467320156;1436.9640758981109;8276.172382761675;8505.404621676547;8515.57422128891;8517.914820851713;8524.104968978292;1120.5797825815318;1129.6667483092508;1129.8305254211934;1142.1719253541282;1144.1190283481671;6395.2645445773405;6477.902831457532;6587.275399706028;6589.7364105435245;6600.339966003361;10259.538320775582;10541.736456588647;10556;10783.730406739738;11028.669139925814;10528.473576321307;10603.681889543326;10774.245802793886;10870.891291087146;10939.687237531547;8041.597920103972;8154.6738130475305;8177.632006559719;8228.053773816087;8245.711400100967;7953.801154971172;8058.033036035713;8227.506349619041;8242;8250.422470427253;9473.289503287144;9484.573194206416;9705.272104592043;9722.708318750449;9868.950655246677;9437.858432123661;9581.185599224144;9906.25703072258;10034.247431442525;10038;6781.898271525833;6915.101036865175;7389.187189409053;7549.886751698619;7694.115176754521;8214.876776848472;8231.547264900248;8269.545175015191;8270.462419942685;8287.58562071906;7311.780646580611;7355.8896616551865;7372.336489715952;7452.366548843409;7626.771196864103;7436.256374362521;7470.103587569526;7479.700811967678;7585.658645360862;7609.39124869998;7531.88702169457;7570.545767253982;7615.619219039137;7655.732049378245;7667.578283194478;6986.196587392515;7023.33278338557;7064.081669382947;7095.0421693070775;7105.18290396611;7314.158871729819;7488.925110748823;7530.623468826647;7533.20901305377;7565.810854728676 04:19:59 INFO - PROCESS | 3378 | |4;prototype.html;318.6160676384955;329.56661989483814;333.4481433228008;334.7706820827733;338.5142320769694;5565.582581306403;5620.718964051796;5622.128570071645;5649.559362362602;5709.115087161486;5559.638623489471;5564.4713752193475;5587.552995760339;5602.019646561846;5602.579806514507;3984.2031593681236;4098.815553300109;4252.872413827575;4348.739075655455;4373.2565463871215;4322.286822674255;4345.760983145926;4354.150940566591;4359.324304732756;4363.323684828857;4298.226319262531;4306.9447985243505;4312.584952426635;4328.653707703392;4333.328334108202;4033.3748269018347;4168.353905144708;4287.399764033006;4288.120935208306;4301.161273551658;3799.5181879067186;3809.733318667694;3811.4854494643146;3826.4260360945805;3837.769733815952;5354.946450535523;5376.354837419495;5379.273798037293;5379.381371142291;5379.462053794628;4882.560569548722;5016.949830501685;5033.270175824485;5035.2195409711185;5035.496450354972;5855.121731740231;5858.941410585882;5870.501007414375;5875.796576283894;5880.500157486619;4256.787160641987;4270.871873843789;4271.829126834923;4278.379634952915;4286.935695964563;5815.534757219412;5872;5991.91012134814;6093.050223928345;6125.111858780497;4305.526392096866;4306.354046892929;4311.827526898889;4316.525182229952;4325.41606883073;4343.1530851484285;4382.298832186835;4388.210122177975;4389.388313953193;4394.714343567722;4888.706677599355;4992.600591952635;5012.774425150877;5029.01353965189;5036.7733451994745;5876.324222714357;5888.676122813286;5890.8821823563285;5893.941060589339;5899.410058994152;1483.4881965721809;1514.4396573267961;1517.6130086827789;1519.5061604978425;1521.414255511636;1021.3004092196869;1038.5845661735216;1051.5846240734868;1059.2426415113232;1066.5200659703164;5613.326400831927;5640.802571910045;5651.15232715096;5655.773769049192;5663.6035477517;6004.699765011732;6006.609570377911;6035.698215089228;6040.154378387029;6042.6978651067275;5441.673499590037;5634.985702573495;5643.689597072118;5674.092145256739;5678.921005009035;3191.122441328653;3198.760092993035;3201.1196920846955;3211.7270032047536;3215.6141263048585;6034.849128771728;6216.844578885564;6223;6223.1287619733275;6230.719617617218;6131.325554189036;6148.6925653717135;6166.1983942087245;6167.506599472032;6172;6206.317305096436;6208.782692605737;6219.0982307566055;6222.719977601018;6229.345918678655;5827.825165245049;6017.939820601738;6024.638521688713;6031.969840150947;6058.242719660043;5914.970425147847;5926.555508336978;5957.582969192115;5968.791092311748;5969.910451343147;5974;6012.098185272244;6277.96861015692;6281.246250449975;6290.591111577733;4300.9247688077985;4305.526392096929;4312.417823593774;4313.425599656166;4314.374415709642;5916.230889984275;6056.303525094494;6085.83536560977;6103.84740381494;6105.954505240794;5894.646321220741;5917.467427931507;5944.108383742473;5946.851328716817;5956.523478121827;5891.410858914246;5904.722878802306;5941.821745347646;5954.672493012753;5956.5532585055425;5711.057675483498;5826.213461182856;5830.250924722482;5842.7662893485485;5880.411958804086;5947.256592925884;5981.371955944737;5988.850278742892;6001.489873360813;6017.428344307284;5692.943070569407;5705;5808.767649293981;5830.737616807169;5837.824865254049 04:19:59 INFO - PROCESS | 3378 | |5;yui.html;666.6233578028414;767.3209209849283;782.5461232485159;838.3460900497606;856.4005196362548;14302.070365426252;14782.704345913075;14821.925890370547;14827.481038163667;14831.703365932688;13762.518311859087;13763.587092387219;13770.173789572633;13809.792853107212;13810.723785524284;653.8888388973862;793.8372633610096;798.3054742374128;814.2997022560593;816.1512027491402;809.8663720486113;817.5340056167987;817.6892780743309;819.0580832043139;821.080389963239;856.3448961544424;858.8024754306513;860.2386887604483;860.724568138196;863.9265662418702;690.6270613868505;849.4096602861014;871.0331531999507;874.9212570868652;879.8768172455862;616.2174038970527;618.7339444039061;619.4208415131822;619.7520991603395;622;14202.360893759806;14206.786898196535;14208.076475029193;14256.572302830931;14260.144391336553;13436.798448023288;13719.314034298344;13761.17432954016;13770.24263665498;13812.37844297009;12304.692382690415;12456.190347627375;12462.688432789162;12787;12851.550195743104;4582.518835522289;4614.446266448014;4665.2768820832825;4674.929876051862;4768.260919557474;53065;53702;54261.72869135629;54297;54541;11431.714207144887;11468.197226194086;11535.538578456935;11536.884631153582;11798.41007949599;20246.69629955552;20286.59426811485;20291.086901089486;20367.18531258733;20474.79525204759;8409.369297302605;8625.266852317623;8704.782380440412;8813.823723525493;9026.729198123936;4840.146491141231;4863.221884498464;4883.951160488421;4909.607231421478;5008.5993120550265;3507.5440192775286;3631.618680038611;3633.7638053526966;3634.254977729559;3640.290143422007;574.3395095639964;664.9534532582672;691.7855464805926;713.6039498078616;721.1598487761804;668.7659319238228;725.147951157388;775.8331958628809;776.2160218179679;786.3001928283832;9151.542422878829;9189.127032931861;9713.125818676353;9721;9880.468527378267;615.5229696984783;638.3839594790957;713.9576218720622;728.1626129950494;731.8389954210065;4506.1663592235545;4646.512116227815;4693.530646935347;4716.481187069419;4751.239801631722;59964.40035599588;61664;61764.073538896955;62045.689771551755;62086;50563.74718126386;53234.73382633062;55167.172492411846;55246.723766380914;55544.72227638917;48596;48978.755106224955;50525.74737126291;50549.49450505521;51139.48860511422;8982.730518084469;9410;9474.336796424459;9491.240700744062;9537.380070295409;33942.49086263659;34432.483512746825;34597.65402345944;34737.47893781646;35281.647183527835;42364.152716946104;44570.55429445664;45932.311015335465;45973.70131493345;46448.76775616236;12116.878831211576;12301.44643491027;12309.1999020067;12351.629451116482;12829.10196286251;13779.104358216684;13877.514286999907;14477.710445791236;14564.344604493035;14903.850961490247;12419.875801241871;13643.317834108057;13650;14323;14560.708785824436;12898.48406063747;13188.868111318763;13703.931480342933;13740.244286564335;13852.93073534626;13329.933350333575;13385.263810490516;13408.195508269535;13852.376643050886;14089.365978531196;10245.846312305172;10275.84586231222;10306.793864122825;10391.948040259751;10554.788904222027;10730.624428144978;11063.170262230526;11093.445327733742;11242.66272011841;11263.887361126284 04:19:59 INFO - PROCESS | 3378 | __end_tp_report 04:19:59 INFO - PROCESS | 3378 | __start_cc_report 04:19:59 INFO - PROCESS | 3378 | _x_x_mozilla_cycle_collect,875 04:19:59 INFO - PROCESS | 3378 | __end_cc_report 04:19:59 INFO - PROCESS | 3378 | __startTimestamp1460459999188__endTimestamp 04:19:59 INFO - PROCESS | 3378 | 04:19:59 INFO - PROCESS | 3378 | ------- Summary: start ------- 04:19:59 INFO - PROCESS | 3378 | Number of tests: 6 04:19:59 INFO - PROCESS | 3378 | 04:19:59 INFO - PROCESS | 3378 | [#0] dojo.html Cycles:165 Average:5368.80 Median:5587.89 stddev:611.95 (11.0%) stddev-sans-first:588.31 04:19:59 INFO - PROCESS | 3378 | Values: 3139.8 3172.9 3205.9 3208.1 3234.2 5407.8 5415.8 5417.6 5456.3 5506.9 5414.3 5431.8 5450.4 5475.7 5503.4 4814.9 4860.9 4876.6 4889.1 5074.2 4966.7 4992.6 5030.1 5034.7 5042.4 4808.4 4831.6 4866.8 4939.7 4997.2 4884.9 4899.0 4910.5 4924.2 4941.2 4858.3 4870.3 4892.0 4901.5 4921.5 5326.2 5364.9 5370.0 5422.9 5423.2 5755.3 5781.0 5786.7 5788.0 5792.5 5633.0 5737.7 5824.1 5824.6 5831.5 5454.7 5454.9 5456.5 5457.9 5495.2 5959.8 5968.2 5970.4 5972.9 5975.4 5555.1 5643.9 5711.4 5724.7 5731.6 5803.7 5831.6 5835.4 5836.2 5848.3 5762.3 5765.2 5781.4 5791.1 5807.9 5658.0 5752.1 5809.3 5844.4 5851.7 4324.1 4344.6 4347.2 4357.3 4393.3 3903.8 3910.2 3918.0 3938.8 3962.7 5270.8 5307.8 5368.1 5375.8 5468.6 5695.9 5700.3 5723.1 5723.5 5726.4 5383.2 5390.1 5402.6 5402.6 5433.5 4717.6 4852.5 4900.0 4909.3 4924.2 5986.3 5990.6 6003.6 6010.9 6027.8 5768.4 5771.5 5772.2 5786.2 5789.0 5825.9 5925.9 6008.7 6075.6 6088.9 5604.4 5636.4 5649.4 5655.3 5665.8 5711.5 5744.9 5751.8 5753.2 5756.4 5521.0 5685.4 5722.5 5769.8 5776.9 5652.8 5661.9 5667.1 5668.3 5668.6 5397.2 5572.7 5591.4 5591.7 5596.9 5723.5 5775.0 5779.3 5788.2 5826.2 5557.0 5569.8 5586.9 5587.9 5633.5 04:19:59 INFO - PROCESS | 3378 | 04:19:59 INFO - PROCESS | 3378 | [#1] ext.html Cycles:180 Average:48158.05 Median:37866.41 stddev:83983.81 (221.8%) stddev-sans-first:84143.64 04:19:59 INFO - PROCESS | 3378 | Values: 644.3 646.1 648.3 660.0 665.7 36035.3 37741.0 37776.4 37864.8 37868.0 42491.0 43202.6 43367.3 43386.8 43404.8 8657.2 8850.5 8855.5 8873.7 8884.3 8618.4 8746.5 8751.6 8753.5 8756.4 8726.8 8793.7 8795.3 8804.3 8815.9 8703.7 8742.3 8765.6 8774.3 8776.9 8728.4 8747.3 8843.3 8844.5 8851.9 38215.2 38827.2 39143.2 39279.0 39398.4 3404.0 3526.6 4014.1 4170.3 4232.2 31228.8 31294.7 31321.2 31414.7 31637.0 4215.4 4243.2 4303.9 4372.0 4373.7 282207.0 283338.0 283898.4 284663.0 284800.0 54353.5 54383.3 54846.5 54849.2 54869.5 49582.0 55866.7 56358.4 57517.0 57984.0 14276.4 14438.5 14495.9 14510.6 14512.0 11227.9 11350.3 11504.0 11504.3 11505.1 13502.2 13982.4 14961.8 15308.7 15510.5 6057.0 6170.8 6205.3 6289.3 6300.7 980.4 1070.7 1112.7 1147.2 1163.5 31110.4 31311.7 31354.5 31516.4 31616.2 1127.7 1133.5 1167.5 1168.9 1240.5 15993.2 16582.8 16629.9 16665.4 16886.4 387158.3 390161.0 391558.0 391820.0 392189.0 53100.0 53877.0 54017.0 54056.7 54128.0 1214.3 1311.0 1352.4 1368.9 1444.8 27521.6 28287.4 28783.0 28833.7 29086.3 37770.6 38152.8 38254.8 38311.0 38364.2 270176.0 272035.0 272608.0 273290.0 273748.0 32913.3 41497.0 42069.6 42626.8 43045.6 42820.8 43007.8 43280.6 43771.6 43862.8 36458.5 36675.6 37152.3 37394.4 37733.6 36200.6 36506.6 36559.5 37026.4 37084.1 36546.5 37018.3 37253.3 37689.8 38200.4 32025.0 33287.0 33295.7 33382.7 33489.2 26053.7 26083.2 26508.5 26544.2 26816.9 04:19:59 INFO - PROCESS | 3378 | 04:19:59 INFO - PROCESS | 3378 | [#2] jquery.html Cycles:180 Average:28600.94 Median:12706.80 stddev:83346.34 (655.9%) stddev-sans-first:83553.25 04:19:59 INFO - PROCESS | 3378 | Values: 403.2 403.6 405.4 406.5 416.0 13575.7 16841.3 17514.4 17834.1 17850.2 17520.1 17888.4 18555.2 19389.5 19454.7 5580.5 5693.1 5838.0 5846.8 5856.7 3909.5 5548.8 5716.4 6149.9 6510.3 6373.2 6456.0 6456.6 6476.9 6486.4 6275.8 6360.2 6444.4 6458.5 6478.7 5516.3 5683.3 5704.8 5712.3 5715.5 22623.3 22852.5 22856.8 23040.7 23086.2 2327.4 2338.6 2399.6 2688.5 2843.4 13073.7 13792.9 14139.0 14239.4 14637.9 1944.1 1978.4 1981.4 2021.3 2097.7 79315.2 80066.0 80932.2 81366.0 82048.6 10356.3 10395.4 10668.2 10715.0 10791.1 13190.7 13787.7 15195.5 15235.3 15245.6 7723.7 7947.8 7956.9 8075.6 8143.1 7311.3 7317.3 7460.9 7482.6 7562.7 6295.9 6356.6 6475.2 6535.1 6570.4 1894.4 1895.7 1927.7 1935.7 1939.1 914.1 1024.5 1030.4 1105.3 1148.5 19384.4 19582.7 19778.3 19888.4 20015.0 1019.5 1053.4 1053.4 1062.1 1091.3 10708.1 11325.7 11400.5 11452.4 11509.9 501313.0 502628.0 503731.0 515368.0 517688.0 80402.2 82020.0 82577.2 83500.0 84086.0 599.9 761.3 988.7 1074.3 1076.3 16369.9 16623.3 16730.2 16965.3 17110.6 23302.4 33036.2 33274.3 34645.3 35143.3 38150.0 40016.6 43605.6 44901.6 45581.1 7430.2 8638.6 8790.3 8835.2 8876.3 12950.3 13010.0 13051.4 13111.9 13146.7 11775.0 11816.1 11881.2 12020.5 12090.9 10963.3 11542.8 11631.3 11707.6 11938.2 11336.4 11596.9 11670.9 12135.5 12341.3 7222.5 8658.7 8808.0 8975.2 9075.6 11509.0 11762.2 11787.6 12226.8 12249.8 04:19:59 INFO - PROCESS | 3378 | 04:19:59 INFO - PROCESS | 3378 | [#3] mootools.html Cycles:180 Average:5995.50 Median:5222.15 stddev:3158.80 (60.5%) stddev-sans-first:3148.42 04:19:59 INFO - PROCESS | 3378 | Values: 1358.0 1496.5 1536.0 1667.9 1800.7 8190.5 8506.1 8508.8 8509.1 8553.4 8260.2 8340.9 8404.1 8420.8 8426.5 2035.8 2310.4 2373.5 2385.5 2399.5 2393.6 2420.0 2422.1 2426.1 2427.3 2374.1 2404.4 2407.7 2407.9 2417.7 2043.5 2319.9 2383.1 2385.4 2392.3 2247.2 2268.1 2274.2 2275.2 2278.1 8206.4 8323.5 8341.2 8344.6 8347.2 5096.2 5191.3 5215.9 5228.4 5319.1 3241.7 3369.7 3395.4 3470.1 3539.8 1148.7 1186.9 1188.9 1204.4 1206.2 11366.3 11450.3 11461.8 11476.4 11500.3 4317.0 4437.1 4598.3 4600.8 4608.0 9305.3 9328.5 9358.6 9369.0 9369.5 4586.4 5261.1 5267.0 5294.8 5307.2 4839.0 4945.9 4950.4 4969.1 4999.0 3724.6 3763.5 3800.8 3835.7 3880.1 1135.4 1142.8 1158.2 1159.0 1191.4 1354.7 1372.0 1395.1 1428.5 1437.0 8276.2 8505.4 8515.6 8517.9 8524.1 1120.6 1129.7 1129.8 1142.2 1144.1 6395.3 6477.9 6587.3 6589.7 6600.3 10259.5 10541.7 10556.0 10783.7 11028.7 10528.5 10603.7 10774.2 10870.9 10939.7 8041.6 8154.7 8177.6 8228.1 8245.7 7953.8 8058.0 8227.5 8242.0 8250.4 9473.3 9484.6 9705.3 9722.7 9869.0 9437.9 9581.2 9906.3 10034.2 10038.0 6781.9 6915.1 7389.2 7549.9 7694.1 8214.9 8231.5 8269.5 8270.5 8287.6 7311.8 7355.9 7372.3 7452.4 7626.8 7436.3 7470.1 7479.7 7585.7 7609.4 7531.9 7570.5 7615.6 7655.7 7667.6 6986.2 7023.3 7064.1 7095.0 7105.2 7314.2 7488.9 7530.6 7533.2 7565.8 04:19:59 INFO - PROCESS | 3378 | 04:19:59 INFO - PROCESS | 3378 | [#4] prototype.html Cycles:180 Average:4945.74 Median:5637.89 stddev:1457.12 (25.8%) stddev-sans-first:1419.22 04:19:59 INFO - PROCESS | 3378 | Values: 318.6 329.6 333.4 334.8 338.5 5565.6 5620.7 5622.1 5649.6 5709.1 5559.6 5564.5 5587.6 5602.0 5602.6 3984.2 4098.8 4252.9 4348.7 4373.3 4322.3 4345.8 4354.2 4359.3 4363.3 4298.2 4306.9 4312.6 4328.7 4333.3 4033.4 4168.4 4287.4 4288.1 4301.2 3799.5 3809.7 3811.5 3826.4 3837.8 5354.9 5376.4 5379.3 5379.4 5379.5 4882.6 5016.9 5033.3 5035.2 5035.5 5855.1 5858.9 5870.5 5875.8 5880.5 4256.8 4270.9 4271.8 4278.4 4286.9 5815.5 5872.0 5991.9 6093.1 6125.1 4305.5 4306.4 4311.8 4316.5 4325.4 4343.2 4382.3 4388.2 4389.4 4394.7 4888.7 4992.6 5012.8 5029.0 5036.8 5876.3 5888.7 5890.9 5893.9 5899.4 1483.5 1514.4 1517.6 1519.5 1521.4 1021.3 1038.6 1051.6 1059.2 1066.5 5613.3 5640.8 5651.2 5655.8 5663.6 6004.7 6006.6 6035.7 6040.2 6042.7 5441.7 5635.0 5643.7 5674.1 5678.9 3191.1 3198.8 3201.1 3211.7 3215.6 6034.8 6216.8 6223.0 6223.1 6230.7 6131.3 6148.7 6166.2 6167.5 6172.0 6206.3 6208.8 6219.1 6222.7 6229.3 5827.8 6017.9 6024.6 6032.0 6058.2 5915.0 5926.6 5957.6 5968.8 5969.9 5974.0 6012.1 6278.0 6281.2 6290.6 4300.9 4305.5 4312.4 4313.4 4314.4 5916.2 6056.3 6085.8 6103.8 6106.0 5894.6 5917.5 5944.1 5946.9 5956.5 5891.4 5904.7 5941.8 5954.7 5956.6 5711.1 5826.2 5830.3 5842.8 5880.4 5947.3 5981.4 5988.9 6001.5 6017.4 5692.9 5705.0 5808.8 5830.7 5837.8 04:19:59 INFO - PROCESS | 3378 | 04:19:59 INFO - PROCESS | 3378 | [#5] yui.html Cycles:180 Average:15031.25 Median:4684.23 stddev:16871.80 (360.2%) stddev-sans-first:16884.64 04:19:59 INFO - PROCESS | 3378 | Values: 666.6 767.3 782.5 838.3 856.4 14302.1 14782.7 14821.9 14827.5 14831.7 13762.5 13763.6 13770.2 13809.8 13810.7 653.9 793.8 798.3 814.3 816.2 809.9 817.5 817.7 819.1 821.1 856.3 858.8 860.2 860.7 863.9 690.6 849.4 871.0 874.9 879.9 616.2 618.7 619.4 619.8 622.0 14202.4 14206.8 14208.1 14256.6 14260.1 13436.8 13719.3 13761.2 13770.2 13812.4 12304.7 12456.2 12462.7 12787.0 12851.6 4582.5 4614.4 4665.3 4674.9 4768.3 53065.0 53702.0 54261.7 54297.0 54541.0 11431.7 11468.2 11535.5 11536.9 11798.4 20246.7 20286.6 20291.1 20367.2 20474.8 8409.4 8625.3 8704.8 8813.8 9026.7 4840.1 4863.2 4884.0 4909.6 5008.6 3507.5 3631.6 3633.8 3634.3 3640.3 574.3 665.0 691.8 713.6 721.2 668.8 725.1 775.8 776.2 786.3 9151.5 9189.1 9713.1 9721.0 9880.5 615.5 638.4 714.0 728.2 731.8 4506.2 4646.5 4693.5 4716.5 4751.2 59964.4 61664.0 61764.1 62045.7 62086.0 50563.7 53234.7 55167.2 55246.7 55544.7 48596.0 48978.8 50525.7 50549.5 51139.5 8982.7 9410.0 9474.3 9491.2 9537.4 33942.5 34432.5 34597.7 34737.5 35281.6 42364.2 44570.6 45932.3 45973.7 46448.8 12116.9 12301.4 12309.2 12351.6 12829.1 13779.1 13877.5 14477.7 14564.3 14903.9 12419.9 13643.3 13650.0 14323.0 14560.7 12898.5 13188.9 13703.9 13740.2 13852.9 13329.9 13385.3 13408.2 13852.4 14089.4 10245.8 10275.8 10306.8 10391.9 10554.8 10730.6 11063.2 11093.4 11242.7 11263.9 04:19:59 INFO - PROCESS | 3378 | -------- Summary: end -------- 04:19:59 INFO - PROCESS | 3378 | 04:19:59 INFO - TEST-INFO | 3378: exit 0 04:19:59 INFO - TEST-OK | dromaeo_css | took 1112497ms 04:19:59 INFO - TEST-START | kraken 04:19:59 INFO - operating with platform_type : linux_ 04:19:59 INFO - Initialising browser for kraken test... 04:19:59 INFO - TEST-INFO | started process 3566 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp6iHS7d/profile http://localhost:38207/getInfo.html) 04:20:03 INFO - PROCESS | 3566 | __metrics Screen width/height:1600/1200 04:20:03 INFO - PROCESS | 3566 | colorDepth:24 04:20:03 INFO - PROCESS | 3566 | Browser inner width/height: 1024/697 04:20:03 INFO - PROCESS | 3566 | __metrics 04:20:04 ERROR - PROCESS | 3566 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:20:05 INFO - TEST-INFO | 3566: exit 0 04:20:05 INFO - Browser initialized. 04:20:05 INFO - Running cycle 1/1 for kraken test... 04:20:05 INFO - TEST-INFO | started process 3648 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp6iHS7d/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:20:16 INFO - PROCESS | 3648 | RSS: Main: 153112576 04:20:16 INFO - PROCESS | 3648 | 04:20:19 INFO - PROCESS | 3648 | Cycle 1(1): loaded http://localhost:38207/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38207/tests/kraken/driver.html?testName=audio-beat-detection) 04:20:20 INFO - PROCESS | 3648 | RSS: Main: 208252928 04:20:20 INFO - PROCESS | 3648 | 04:20:22 INFO - PROCESS | 3648 | Cycle 1(1): loaded http://localhost:38207/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38207/tests/kraken/driver.html?testName=audio-dft) 04:20:23 INFO - PROCESS | 3648 | RSS: Main: 193572864 04:20:23 INFO - PROCESS | 3648 | 04:20:26 INFO - PROCESS | 3648 | Cycle 1(1): loaded http://localhost:38207/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38207/tests/kraken/driver.html?testName=audio-fft) 04:20:27 INFO - PROCESS | 3648 | RSS: Main: 264228864 04:20:27 INFO - PROCESS | 3648 | 04:20:29 INFO - PROCESS | 3648 | Cycle 1(1): loaded http://localhost:38207/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38207/tests/kraken/driver.html?testName=audio-oscillator) 04:20:29 INFO - PROCESS | 3648 | RSS: Main: 172699648 04:20:29 INFO - PROCESS | 3648 | 04:20:32 INFO - PROCESS | 3648 | Cycle 1(1): loaded http://localhost:38207/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38207/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:20:32 INFO - PROCESS | 3648 | RSS: Main: 178081792 04:20:32 INFO - PROCESS | 3648 | 04:20:35 INFO - PROCESS | 3648 | Cycle 1(1): loaded http://localhost:38207/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38207/tests/kraken/driver.html?testName=imaging-darkroom) 04:20:36 INFO - PROCESS | 3648 | RSS: Main: 214204416 04:20:36 INFO - PROCESS | 3648 | 04:20:39 INFO - PROCESS | 3648 | Cycle 1(1): loaded http://localhost:38207/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38207/tests/kraken/driver.html?testName=imaging-desaturate) 04:20:40 INFO - PROCESS | 3648 | RSS: Main: 215281664 04:20:40 INFO - PROCESS | 3648 | 04:20:42 INFO - PROCESS | 3648 | Cycle 1(1): loaded http://localhost:38207/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38207/tests/kraken/driver.html?testName=json-parse-financial) 04:20:43 INFO - PROCESS | 3648 | RSS: Main: 215003136 04:20:43 INFO - PROCESS | 3648 | 04:20:45 INFO - PROCESS | 3648 | Cycle 1(1): loaded http://localhost:38207/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38207/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:20:45 INFO - PROCESS | 3648 | RSS: Main: 204009472 04:20:45 INFO - PROCESS | 3648 | 04:20:47 INFO - PROCESS | 3648 | Cycle 1(1): loaded http://localhost:38207/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38207/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:20:48 INFO - PROCESS | 3648 | RSS: Main: 207429632 04:20:48 INFO - PROCESS | 3648 | 04:20:50 INFO - PROCESS | 3648 | Cycle 1(1): loaded http://localhost:38207/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38207/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:20:50 INFO - PROCESS | 3648 | RSS: Main: 220377088 04:20:50 INFO - PROCESS | 3648 | 04:20:53 INFO - PROCESS | 3648 | Cycle 1(1): loaded http://localhost:38207/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38207/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:20:53 INFO - PROCESS | 3648 | RSS: Main: 221442048 04:20:53 INFO - PROCESS | 3648 | 04:20:56 INFO - PROCESS | 3648 | Cycle 1(1): loaded http://localhost:38207/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38207/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:20:57 INFO - PROCESS | 3648 | RSS: Main: 220512256 04:20:57 INFO - PROCESS | 3648 | 04:20:59 INFO - PROCESS | 3648 | Cycle 1(1): loaded http://localhost:38207/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38207/tests/kraken/driver.html?testName=ai-astar) 04:20:59 INFO - PROCESS | 3648 | RSS: Main: 283226112 04:20:59 INFO - PROCESS | 3648 | 04:20:59 INFO - PROCESS | 3648 | __start_tp_report 04:20:59 INFO - PROCESS | 3648 | _x_x_mozilla_page_load 04:20:59 INFO - PROCESS | 3648 | _x_x_mozilla_page_load_details 04:20:59 INFO - PROCESS | 3648 | |i|pagename|runs| 04:20:59 INFO - PROCESS | 3648 | |0;ai-astar;109;111;106;110;111;112;100;109;110;109 04:20:59 INFO - PROCESS | 3648 | |1;audio-beat-detection;156;129;158;186;129;166;154;130;187;127 04:20:59 INFO - PROCESS | 3648 | |2;audio-dft;162;162;162;161;161;161;160;161;161;161 04:20:59 INFO - PROCESS | 3648 | |3;audio-fft;72;73;96;108;76;74;77;109;104;76 04:20:59 INFO - PROCESS | 3648 | |4;audio-oscillator;93;94;146;94;94;93;151;93;92;144 04:20:59 INFO - PROCESS | 3648 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;117;116;118 04:20:59 INFO - PROCESS | 3648 | |6;imaging-darkroom;147;147;147;147;146;145;145;146;145;145 04:20:59 INFO - PROCESS | 3648 | |7;imaging-desaturate;95;95;95;95;95;95;95;94;96;95 04:20:59 INFO - PROCESS | 3648 | |8;json-parse-financial;58;57;58;57;58;58;58;70;56;56 04:20:59 INFO - PROCESS | 3648 | |9;json-stringify-tinderbox;62;62;62;63;62;63;63;63;62;63 04:20:59 INFO - PROCESS | 3648 | |10;stanford-crypto-aes;79;80;81;79;80;79;80;81;82;81 04:20:59 INFO - PROCESS | 3648 | |11;stanford-crypto-ccm;132;131;130;130;129;125;129;127;194;138 04:20:59 INFO - PROCESS | 3648 | |12;stanford-crypto-pbkdf2;167;167;167;166;167;164;168;173;165;166 04:20:59 INFO - PROCESS | 3648 | |13;stanford-crypto-sha256-iterative;67;67;67;66;69;68;66;66;75;65 04:20:59 INFO - PROCESS | 3648 | __end_tp_report 04:20:59 INFO - PROCESS | 3648 | __start_cc_report 04:20:59 INFO - PROCESS | 3648 | _x_x_mozilla_cycle_collect,1639 04:20:59 INFO - PROCESS | 3648 | __end_cc_report 04:20:59 INFO - PROCESS | 3648 | __startTimestamp1460460059268__endTimestamp 04:20:59 INFO - PROCESS | 3648 | 04:20:59 INFO - PROCESS | 3648 | ------- Summary: start ------- 04:20:59 INFO - PROCESS | 3648 | Number of tests: 14 04:20:59 INFO - PROCESS | 3648 | 04:20:59 INFO - PROCESS | 3648 | [#0] ai-astar Cycles:10 Average:108.70 Median:110.00 stddev:3.47 (3.2%) stddev-sans-first:3.67 04:20:59 INFO - PROCESS | 3648 | Values: 109.0 111.0 106.0 110.0 111.0 112.0 100.0 109.0 110.0 109.0 04:20:59 INFO - PROCESS | 3648 | 04:20:59 INFO - PROCESS | 3648 | [#1] audio-beat-detection Cycles:10 Average:152.20 Median:157.00 stddev:23.09 (14.7%) stddev-sans-first:24.45 04:20:59 INFO - PROCESS | 3648 | Values: 156.0 129.0 158.0 186.0 129.0 166.0 154.0 130.0 187.0 127.0 04:20:59 INFO - PROCESS | 3648 | 04:20:59 INFO - PROCESS | 3648 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 04:20:59 INFO - PROCESS | 3648 | Values: 162.0 162.0 162.0 161.0 161.0 161.0 160.0 161.0 161.0 161.0 04:20:59 INFO - PROCESS | 3648 | 04:20:59 INFO - PROCESS | 3648 | [#3] audio-fft Cycles:10 Average:86.50 Median:75.00 stddev:15.72 (21.0%) stddev-sans-first:15.78 04:20:59 INFO - PROCESS | 3648 | Values: 72.0 73.0 96.0 108.0 76.0 74.0 77.0 109.0 104.0 76.0 04:20:59 INFO - PROCESS | 3648 | 04:20:59 INFO - PROCESS | 3648 | [#4] audio-oscillator Cycles:10 Average:109.40 Median:93.00 stddev:26.01 (28.0%) stddev-sans-first:26.90 04:20:59 INFO - PROCESS | 3648 | Values: 93.0 94.0 146.0 94.0 94.0 93.0 151.0 93.0 92.0 144.0 04:20:59 INFO - PROCESS | 3648 | 04:20:59 INFO - PROCESS | 3648 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 04:20:59 INFO - PROCESS | 3648 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 118.0 04:20:59 INFO - PROCESS | 3648 | 04:20:59 INFO - PROCESS | 3648 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.50 stddev:0.94 (0.6%) stddev-sans-first:0.93 04:20:59 INFO - PROCESS | 3648 | Values: 147.0 147.0 147.0 147.0 146.0 145.0 145.0 146.0 145.0 145.0 04:20:59 INFO - PROCESS | 3648 | 04:20:59 INFO - PROCESS | 3648 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 04:20:59 INFO - PROCESS | 3648 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 96.0 95.0 04:20:59 INFO - PROCESS | 3648 | 04:20:59 INFO - PROCESS | 3648 | [#8] json-parse-financial Cycles:10 Average:58.60 Median:58.00 stddev:4.09 (7.0%) stddev-sans-first:4.33 04:20:59 INFO - PROCESS | 3648 | Values: 58.0 57.0 58.0 57.0 58.0 58.0 58.0 70.0 56.0 56.0 04:20:59 INFO - PROCESS | 3648 | 04:20:59 INFO - PROCESS | 3648 | [#9] json-stringify-tinderbox Cycles:10 Average:62.50 Median:63.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 04:20:59 INFO - PROCESS | 3648 | Values: 62.0 62.0 62.0 63.0 62.0 63.0 63.0 63.0 62.0 63.0 04:20:59 INFO - PROCESS | 3648 | 04:20:59 INFO - PROCESS | 3648 | [#10] stanford-crypto-aes Cycles:10 Average:80.20 Median:80.50 stddev:1.03 (1.3%) stddev-sans-first:1.00 04:20:59 INFO - PROCESS | 3648 | Values: 79.0 80.0 81.0 79.0 80.0 79.0 80.0 81.0 82.0 81.0 04:20:59 INFO - PROCESS | 3648 | 04:20:59 INFO - PROCESS | 3648 | [#11] stanford-crypto-ccm Cycles:10 Average:136.50 Median:130.50 stddev:20.49 (15.7%) stddev-sans-first:21.67 04:20:59 INFO - PROCESS | 3648 | Values: 132.0 131.0 130.0 130.0 129.0 125.0 129.0 127.0 194.0 138.0 04:20:59 INFO - PROCESS | 3648 | 04:20:59 INFO - PROCESS | 3648 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.00 Median:167.00 stddev:2.40 (1.4%) stddev-sans-first:2.55 04:20:59 INFO - PROCESS | 3648 | Values: 167.0 167.0 167.0 166.0 167.0 164.0 168.0 173.0 165.0 166.0 04:20:59 INFO - PROCESS | 3648 | 04:20:59 INFO - PROCESS | 3648 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:67.00 stddev:2.84 (4.2%) stddev-sans-first:3.00 04:20:59 INFO - PROCESS | 3648 | Values: 67.0 67.0 67.0 66.0 69.0 68.0 66.0 66.0 75.0 65.0 04:20:59 INFO - PROCESS | 3648 | -------- Summary: end -------- 04:20:59 INFO - PROCESS | 3648 | 04:21:00 INFO - TEST-INFO | 3648: exit 0 04:21:00 INFO - TEST-OK | kraken | took 60295ms 04:21:00 INFO - SUITE-END | took 1172s 04:21:00 INFO - Completed test suite (00:19:33) 04:21:00 INFO - javascript benchmark 04:21:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3139.8273094979772, 3172.9206769830766, 3205.871765129395, 3208.1017315151767, 3234.2237862912903, 5407.810726624564, 5415.83752487425, 5417.593680473966, 5456.290682211317, 5506.917396239055, 5414.3232095988005, 5431.83704488865, 5450.427705090968, 5475.698836563987, 5503.449655034495, 4814.879628009293, 4860.927086093711, 4876.585490233334, 4889.119958407486, 5074.162763144095, 4966.701997880121, 4992.550670439659, 5030.11972904742, 5034.723090230036, 5042.445331013586, 4808.3989501312335, 4831.637627177975, 4866.78099485524, 4939.728314942677, 4997.175466048097, 4884.877878053077, 4898.951010489921, 4910.533499317559, 4924.212126059849, 4941.184704523749, 4858.344123543347, 4870.342503761982, 4891.951080489185, 4901.485344038896, 4921.458639549646, 5326.174442961308, 5364.892702145935, 5370.0, 5422.8915421691345, 5423.159410291411, 5755.251817263771, 5780.9710951445395, 5786.7395967181155, 5788.04497257952, 5792.507636850873, 5633.042382794934, 5737.684427356494, 5824.097264923944, 5824.621399609012, 5831.475167234927, 5454.699991500466, 5454.91817622736, 5456.454354564551, 5457.863553411157, 5495.203195536625, 5959.791407300723, 5968.1644569760265, 5970.373110823388, 5972.8805423892145, 5975.4024597540765, 5555.111182210827, 5643.915341269884, 5711.371749107595, 5724.713764311768, 5731.570132240098, 5803.680797556175, 5831.620944638585, 5835.44563266489, 5836.212111364912, 5848.298204215522, 5762.2509073820975, 5765.221695071195, 5781.4218578141845, 5791.073428251544, 5807.912881306784, 5657.971710141423, 5752.07966725322, 5809.331926828384, 5844.386339434298, 5851.736671849777, 4324.0919406924895, 4344.630706389929, 4347.152305300436, 4357.346398040319, 4393.340998850198, 3903.843846246175, 3910.237503686754, 3918.0204948762807, 3938.78336691479, 3962.7226094173707, 5270.789168433296, 5307.761150748225, 5368.141097424394, 5375.838724838261, 5468.644538105011, 5695.943040569624, 5700.25896633435, 5723.112917497794, 5723.456271654186, 5726.3700992890745, 5383.246345511631, 5390.0836857734275, 5402.594805389612, 5402.648827826179, 5433.510984011458, 4717.646176536773, 4852.51474852519, 4900.0, 4909.337239472626, 4924.236743304722, 5986.2517185351835, 5990.580659353891, 6003.609765365237, 6010.939890601126, 6027.7890273841085, 5768.423157684198, 5771.480566748929, 5772.163036359789, 5786.247787787729, 5788.971055144697, 5825.883482330245, 5925.940740592711, 6008.669523176267, 6075.635461872302, 6088.939110608837, 5604.411536788742, 5636.351819540641, 5649.435056494318, 5655.3213614364895, 5665.801696940587, 5711.485966263056, 5744.942550574608, 5751.798687045934, 5753.165790960204, 5756.395578464369, 5521.0, 5685.403032681675, 5722.484976352148, 5769.798057067983, 5776.942230577641, 5652.7738890443925, 5661.943380566307, 5667.121596152603, 5668.26312579362, 5668.574856885833, 5397.190421436816, 5572.749226284745, 5591.356993945748, 5591.692456914909, 5596.86007849807, 5723.542116630576, 5775.018246897954, 5779.335376431764, 5788.160716695971, 5826.213461182686, 5556.998182290263, 5569.805056822992, 5586.916196257141, 5587.8882422352135, 5633.492985631313], "value": 5327.755166997239, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [644.3202421445374, 646.1406329581657, 648.3063122458968, 659.97030133644, 665.7270519087173, 36035.2792944141, 37741.0, 37776.43335349965, 37864.810675946654, 37868.0, 42491.0, 43202.56797432025, 43367.34948975768, 43386.7830660847, 43404.78297608507, 8657.177568131017, 8850.468971861677, 8855.512946787923, 8873.73378798637, 8884.289256859436, 8618.396712230146, 8746.475211487332, 8751.562421878913, 8753.47479151253, 8756.430831995931, 8726.781830454225, 8793.736187914374, 8795.284919440712, 8804.295656347509, 8815.867761983576, 8703.695370662028, 8742.344324175649, 8765.649374025032, 8774.341924355667, 8776.868346974801, 8728.43265187767, 8747.300215982707, 8843.336749743796, 8844.46933184011, 8851.867221991612, 38215.23569528622, 38827.22345553101, 39143.21713565713, 39279.0, 39398.40902386467, 3404.0, 3526.5944416392185, 4014.0566966762785, 4170.311898536738, 4232.217039847638, 31228.843855780804, 31294.687053129404, 31321.216969575715, 31414.685853141404, 31637.0, 4215.43091682622, 4243.151369726067, 4303.935440968388, 4372.016296333331, 4373.650107991353, 282207.0, 283338.0, 283898.3855887946, 284663.0, 284800.0, 54353.456465434836, 54383.280835958045, 54846.451535484935, 54849.177262341094, 54869.45130548723, 49582.0, 55866.72066639722, 56358.43641563614, 57517.0, 57984.0, 14276.357563909649, 14438.494652687315, 14495.927520362542, 14510.637234069021, 14512.04087448181, 11227.943860280646, 11350.262232954832, 11504.0, 11504.252223605607, 11505.079593632488, 13502.189868607915, 13982.370793314325, 14961.775573366409, 15308.693826123415, 15510.534683959499, 6056.969715151484, 6170.784022559279, 6205.28639206488, 6289.339619339995, 6300.716467758962, 980.3774603127066, 1070.6787963610886, 1112.7496313329436, 1147.208426185929, 1163.4822503985815, 31110.377792444477, 31311.686883131333, 31354.52968205479, 31516.36967260642, 31616.209594759854, 1127.6617014895498, 1133.5069244878505, 1167.497975870384, 1168.9298642081503, 1240.5499139200008, 15993.200339983186, 16582.75125873089, 16629.916850415913, 16665.41895621524, 16886.40897568579, 387158.34837342234, 390161.0, 391558.0, 391820.0, 392189.0, 53100.0, 53877.0, 54017.0, 54056.72971635117, 54128.0, 1214.2532342609231, 1310.9803352949714, 1352.4184600621827, 1368.939745682761, 1444.83384410792, 27521.587176192774, 28287.43425131527, 28783.0, 28833.711662883103, 29086.27284317824, 37770.62229377781, 38152.809235953646, 38254.808725956194, 38311.0, 38364.23271534498, 270176.0, 272035.0, 272608.0, 273290.0, 273748.0, 32913.34173316472, 41497.0, 42069.57930420656, 42626.78686606547, 43045.569544304155, 42820.78589607032, 43007.78496107499, 43280.56719432891, 43771.56228437675, 43862.78068609637, 36458.45312320264, 36675.633243667224, 37152.256954861296, 37394.43908341323, 37733.622663773014, 36200.63799362078, 36506.63493365139, 36559.45160822643, 37026.444603330434, 37084.072898177765, 36546.451803222444, 37018.25963480769, 37253.25493490169, 37689.81155094207, 38200.426993595676, 32025.0, 33287.0, 33295.66704332926, 33382.66617333796, 33489.16277092995, 26053.739462605132, 26083.217503474927, 26508.469830602895, 26544.203673889813, 26816.865915670296], "value": 18711.47261533296, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [403.151366373783, 403.61253196930954, 405.4364433437522, 406.51421551246256, 415.9563245859185, 13575.660608484794, 16841.326346946124, 17514.386996455127, 17834.10829458527, 17850.196741146647, 17520.123993800324, 17888.37390691326, 18555.165017574207, 19389.515262118417, 19454.708179377285, 5580.497755202041, 5693.146028095777, 5837.970810145965, 5846.795362162326, 5856.707164641751, 3909.5113110861143, 5548.833534993957, 5716.399778023289, 6149.877002459948, 6510.283868774431, 6373.235211774593, 6456.031595260702, 6456.579552498443, 6476.870462590746, 6486.4162225399705, 6275.811725648215, 6360.173177486943, 6444.387783160616, 6458.451031662315, 6478.676066196671, 5516.345096471083, 5683.318001839764, 5704.80033198836, 5712.343080545749, 5715.542756579505, 22623.321300361014, 22852.54294914109, 22856.77143228563, 23040.65439018416, 23086.191983280503, 2327.4065113395977, 2338.6024375856146, 2399.6040653292184, 2688.5295073362086, 2843.4170994945985, 13073.673158171121, 13792.93103534486, 14139.0, 14239.430422783076, 14637.92681036588, 1944.0862794486568, 1978.3768113044346, 1981.4154824326858, 2021.3228568429595, 2097.6643737002005, 79315.20684793194, 80066.0, 80932.19067809306, 81366.0, 82048.58975705144, 10356.326838755456, 10395.428251446243, 10668.199885008655, 10715.0, 10791.082757965503, 13190.73618527624, 13787.724245515034, 15195.544133676007, 15235.314410851539, 15245.6188595286, 7723.729669461542, 7947.841043179104, 7956.880646790303, 8075.596220188967, 8143.063547692092, 7311.341979221896, 7317.341439270491, 7460.85078298431, 7482.625868706543, 7562.659680314399, 6295.874082518324, 6356.586821856657, 6475.222973243147, 6535.117759102461, 6570.408663220238, 1894.4316704988448, 1895.6966885298561, 1927.6722957097327, 1935.7386752788193, 1939.1370839976075, 914.085914085914, 1024.472396715692, 1030.3611760708259, 1105.3036586950332, 1148.529103067755, 19384.418467445717, 19582.706259405837, 19778.30775922836, 19888.403347899588, 20015.0, 1019.4647809899714, 1053.4364115198332, 1053.4364115198332, 1062.1131355318241, 1091.3397394576325, 10708.1433485321, 11325.716857078474, 11400.543978240778, 11452.3701196435, 11509.884901150881, 501313.0, 502628.0, 503731.0, 515368.0, 517688.0, 80402.19597804065, 82020.0, 82577.17422825815, 83500.0, 84086.0, 599.868029033612, 761.3300295739824, 988.7280997725683, 1074.2909679611419, 1076.252004856617, 16369.87191665076, 16623.3350665972, 16730.16349182512, 16965.321387144868, 17110.572235694206, 23302.417439564146, 33036.1740956478, 33274.33451331008, 34645.333227460345, 35143.297134056666, 38150.0, 40016.59983400129, 43605.56394436015, 44901.55098448974, 45581.08837823159, 7430.219826918095, 8638.611262493077, 8790.340724445565, 8835.20483156519, 8876.28989680811, 12950.287734174712, 13010.0, 13051.412686429323, 13111.868881311446, 13146.737065258832, 11775.0, 11816.113791465503, 11881.168318217642, 12020.519179232733, 12090.939545302217, 10963.342199468058, 11542.769144616892, 11631.302121872715, 11707.590234341757, 11938.22401543897, 11336.376499292619, 11596.88403115958, 11670.94164529172, 12135.514579416724, 12341.321227332583, 7222.494425390172, 8658.740237792876, 8807.955960220157, 8975.192232699088, 9075.636974520945, 11509.0, 11762.176647634584, 11787.587434439753, 12226.75546489083, 12249.755004900031], "value": 9222.174576173697, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1357.952471663492, 1496.5136330692524, 1536.0169491525426, 1667.9082650454227, 1800.7388928605353, 8190.54951977641, 8506.064332923374, 8508.78728031798, 8509.106543812903, 8553.358498112651, 8260.215279548449, 8340.874886876687, 8404.07555168931, 8420.821085048097, 8426.494410335385, 2035.8065983731522, 2310.445493081665, 2373.537160253751, 2385.522895420914, 2399.5320912422085, 2393.5811233034237, 2420.044082587377, 2422.1159276863905, 2426.0902161689364, 2427.3082171581104, 2374.0622454130694, 2404.350825277174, 2407.735149133594, 2407.879606019701, 2417.685700858886, 2043.4789128772143, 2319.895604697793, 2383.07060246504, 2385.3798012516695, 2392.2823153054014, 2247.224707475918, 2268.0814270220585, 2274.20402858998, 2275.16956310947, 2278.054607337953, 8206.384521160877, 8323.542205178714, 8341.165883411672, 8344.582770861492, 8347.248747612683, 5096.159133742965, 5191.299174611417, 5215.895682086375, 5228.398734145546, 5319.148936170194, 3241.6758324167395, 3369.6630336966355, 3395.3548825723033, 3470.1498132957336, 3539.823008849547, 1148.707079694681, 1186.9228500147549, 1188.881111888813, 1204.403820109043, 1206.221986818497, 11366.261193022427, 11450.312981221154, 11461.828072578917, 11476.368799716012, 11500.309981401058, 4317.0, 4437.112577484516, 4598.3102534620075, 4600.769961501912, 4607.976960115178, 9305.302102342352, 9328.486933218603, 9358.57886395114, 9369.0, 9369.531523423802, 4586.380838586748, 5261.105612045885, 5266.97366513165, 5294.814681486129, 5307.177387504943, 4839.0, 4945.9258111128365, 4950.430700469492, 4969.130402179604, 4998.975005125024, 3724.5902950675404, 3763.49192858966, 3800.7837492002295, 3835.6931445484292, 3880.0881792778673, 1135.392564977733, 1142.8228624563205, 1158.1834806461425, 1158.9942050289694, 1191.4162060590422, 1354.7290541891662, 1372.0, 1395.141987677571, 1428.4500467320156, 1436.9640758981109, 8276.172382761675, 8505.404621676547, 8515.57422128891, 8517.914820851713, 8524.104968978292, 1120.5797825815318, 1129.6667483092508, 1129.8305254211934, 1142.1719253541282, 1144.1190283481671, 6395.2645445773405, 6477.902831457532, 6587.275399706028, 6589.7364105435245, 6600.339966003361, 10259.538320775582, 10541.736456588647, 10556.0, 10783.730406739738, 11028.669139925814, 10528.473576321307, 10603.681889543326, 10774.245802793886, 10870.891291087146, 10939.687237531547, 8041.597920103972, 8154.6738130475305, 8177.632006559719, 8228.053773816087, 8245.711400100967, 7953.801154971172, 8058.033036035713, 8227.506349619041, 8242.0, 8250.422470427253, 9473.289503287144, 9484.573194206416, 9705.272104592043, 9722.708318750449, 9868.950655246677, 9437.858432123661, 9581.185599224144, 9906.25703072258, 10034.247431442525, 10038.0, 6781.898271525833, 6915.101036865175, 7389.187189409053, 7549.886751698619, 7694.115176754521, 8214.876776848472, 8231.547264900248, 8269.545175015191, 8270.462419942685, 8287.58562071906, 7311.780646580611, 7355.8896616551865, 7372.336489715952, 7452.366548843409, 7626.771196864103, 7436.256374362521, 7470.103587569526, 7479.700811967678, 7585.658645360862, 7609.39124869998, 7531.88702169457, 7570.545767253982, 7615.619219039137, 7655.732049378245, 7667.578283194478, 6986.196587392515, 7023.33278338557, 7064.081669382947, 7095.0421693070775, 7105.18290396611, 7314.158871729819, 7488.925110748823, 7530.623468826647, 7533.20901305377, 7565.810854728676], "value": 4883.603623294867, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.6160676384955, 329.56661989483814, 333.4481433228008, 334.7706820827733, 338.5142320769694, 5565.582581306403, 5620.718964051796, 5622.128570071645, 5649.559362362602, 5709.115087161486, 5559.638623489471, 5564.4713752193475, 5587.552995760339, 5602.019646561846, 5602.579806514507, 3984.2031593681236, 4098.815553300109, 4252.872413827575, 4348.739075655455, 4373.2565463871215, 4322.286822674255, 4345.760983145926, 4354.150940566591, 4359.324304732756, 4363.323684828857, 4298.226319262531, 4306.9447985243505, 4312.584952426635, 4328.653707703392, 4333.328334108202, 4033.3748269018347, 4168.353905144708, 4287.399764033006, 4288.120935208306, 4301.161273551658, 3799.5181879067186, 3809.733318667694, 3811.4854494643146, 3826.4260360945805, 3837.769733815952, 5354.946450535523, 5376.354837419495, 5379.273798037293, 5379.381371142291, 5379.462053794628, 4882.560569548722, 5016.949830501685, 5033.270175824485, 5035.2195409711185, 5035.496450354972, 5855.121731740231, 5858.941410585882, 5870.501007414375, 5875.796576283894, 5880.500157486619, 4256.787160641987, 4270.871873843789, 4271.829126834923, 4278.379634952915, 4286.935695964563, 5815.534757219412, 5872.0, 5991.91012134814, 6093.050223928345, 6125.111858780497, 4305.526392096866, 4306.354046892929, 4311.827526898889, 4316.525182229952, 4325.41606883073, 4343.1530851484285, 4382.298832186835, 4388.210122177975, 4389.388313953193, 4394.714343567722, 4888.706677599355, 4992.600591952635, 5012.774425150877, 5029.01353965189, 5036.7733451994745, 5876.324222714357, 5888.676122813286, 5890.8821823563285, 5893.941060589339, 5899.410058994152, 1483.4881965721809, 1514.4396573267961, 1517.6130086827789, 1519.5061604978425, 1521.414255511636, 1021.3004092196869, 1038.5845661735216, 1051.5846240734868, 1059.2426415113232, 1066.5200659703164, 5613.326400831927, 5640.802571910045, 5651.15232715096, 5655.773769049192, 5663.6035477517, 6004.699765011732, 6006.609570377911, 6035.698215089228, 6040.154378387029, 6042.6978651067275, 5441.673499590037, 5634.985702573495, 5643.689597072118, 5674.092145256739, 5678.921005009035, 3191.122441328653, 3198.760092993035, 3201.1196920846955, 3211.7270032047536, 3215.6141263048585, 6034.849128771728, 6216.844578885564, 6223.0, 6223.1287619733275, 6230.719617617218, 6131.325554189036, 6148.6925653717135, 6166.1983942087245, 6167.506599472032, 6172.0, 6206.317305096436, 6208.782692605737, 6219.0982307566055, 6222.719977601018, 6229.345918678655, 5827.825165245049, 6017.939820601738, 6024.638521688713, 6031.969840150947, 6058.242719660043, 5914.970425147847, 5926.555508336978, 5957.582969192115, 5968.791092311748, 5969.910451343147, 5974.0, 6012.098185272244, 6277.96861015692, 6281.246250449975, 6290.591111577733, 4300.9247688077985, 4305.526392096929, 4312.417823593774, 4313.425599656166, 4314.374415709642, 5916.230889984275, 6056.303525094494, 6085.83536560977, 6103.84740381494, 6105.954505240794, 5894.646321220741, 5917.467427931507, 5944.108383742473, 5946.851328716817, 5956.523478121827, 5891.410858914246, 5904.722878802306, 5941.821745347646, 5954.672493012753, 5956.5532585055425, 5711.057675483498, 5826.213461182856, 5830.250924722482, 5842.7662893485485, 5880.411958804086, 5947.256592925884, 5981.371955944737, 5988.850278742892, 6001.489873360813, 6017.428344307284, 5692.943070569407, 5705.0, 5808.767649293981, 5830.737616807169, 5837.824865254049], "value": 4478.801563191166, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [666.6233578028414, 767.3209209849283, 782.5461232485159, 838.3460900497606, 856.4005196362548, 14302.070365426252, 14782.704345913075, 14821.925890370547, 14827.481038163667, 14831.703365932688, 13762.518311859087, 13763.587092387219, 13770.173789572633, 13809.792853107212, 13810.723785524284, 653.8888388973862, 793.8372633610096, 798.3054742374128, 814.2997022560593, 816.1512027491402, 809.8663720486113, 817.5340056167987, 817.6892780743309, 819.0580832043139, 821.080389963239, 856.3448961544424, 858.8024754306513, 860.2386887604483, 860.724568138196, 863.9265662418702, 690.6270613868505, 849.4096602861014, 871.0331531999507, 874.9212570868652, 879.8768172455862, 616.2174038970527, 618.7339444039061, 619.4208415131822, 619.7520991603395, 622.0, 14202.360893759806, 14206.786898196535, 14208.076475029193, 14256.572302830931, 14260.144391336553, 13436.798448023288, 13719.314034298344, 13761.17432954016, 13770.24263665498, 13812.37844297009, 12304.692382690415, 12456.190347627375, 12462.688432789162, 12787.0, 12851.550195743104, 4582.518835522289, 4614.446266448014, 4665.2768820832825, 4674.929876051862, 4768.260919557474, 53065.0, 53702.0, 54261.72869135629, 54297.0, 54541.0, 11431.714207144887, 11468.197226194086, 11535.538578456935, 11536.884631153582, 11798.41007949599, 20246.69629955552, 20286.59426811485, 20291.086901089486, 20367.18531258733, 20474.79525204759, 8409.369297302605, 8625.266852317623, 8704.782380440412, 8813.823723525493, 9026.729198123936, 4840.146491141231, 4863.221884498464, 4883.951160488421, 4909.607231421478, 5008.5993120550265, 3507.5440192775286, 3631.618680038611, 3633.7638053526966, 3634.254977729559, 3640.290143422007, 574.3395095639964, 664.9534532582672, 691.7855464805926, 713.6039498078616, 721.1598487761804, 668.7659319238228, 725.147951157388, 775.8331958628809, 776.2160218179679, 786.3001928283832, 9151.542422878829, 9189.127032931861, 9713.125818676353, 9721.0, 9880.468527378267, 615.5229696984783, 638.3839594790957, 713.9576218720622, 728.1626129950494, 731.8389954210065, 4506.1663592235545, 4646.512116227815, 4693.530646935347, 4716.481187069419, 4751.239801631722, 59964.40035599588, 61664.0, 61764.073538896955, 62045.689771551755, 62086.0, 50563.74718126386, 53234.73382633062, 55167.172492411846, 55246.723766380914, 55544.72227638917, 48596.0, 48978.755106224955, 50525.74737126291, 50549.49450505521, 51139.48860511422, 8982.730518084469, 9410.0, 9474.336796424459, 9491.240700744062, 9537.380070295409, 33942.49086263659, 34432.483512746825, 34597.65402345944, 34737.47893781646, 35281.647183527835, 42364.152716946104, 44570.55429445664, 45932.311015335465, 45973.70131493345, 46448.76775616236, 12116.878831211576, 12301.44643491027, 12309.1999020067, 12351.629451116482, 12829.10196286251, 13779.104358216684, 13877.514286999907, 14477.710445791236, 14564.344604493035, 14903.850961490247, 12419.875801241871, 13643.317834108057, 13650.0, 14323.0, 14560.708785824436, 12898.48406063747, 13188.868111318763, 13703.931480342933, 13740.244286564335, 13852.93073534626, 13329.933350333575, 13385.263810490516, 13408.195508269535, 13852.376643050886, 14089.365978531196, 10245.846312305172, 10275.84586231222, 10306.793864122825, 10391.948040259751, 10554.788904222027, 10730.624428144978, 11063.170262230526, 11093.445327733742, 11242.66272011841, 11263.887361126284], "value": 6936.422331905094, "unit": "score"}], "name": "dromaeo_css", "value": 7201.5663657476525, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 111.0, 106.0, 110.0, 111.0, 112.0, 100.0, 109.0, 110.0, 109.0], "value": 108.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 129.0, 158.0, 186.0, 129.0, 166.0, 154.0, 130.0, 187.0, 127.0], "value": 152.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 161.0, 161.0, 161.0, 160.0, 161.0, 161.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 96.0, 108.0, 76.0, 74.0, 77.0, 109.0, 104.0, 76.0], "value": 86.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 146.0, 94.0, 94.0, 93.0, 151.0, 93.0, 92.0, 144.0], "value": 109.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 118.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 96.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 58.0, 57.0, 58.0, 58.0, 58.0, 70.0, 56.0, 56.0], "value": 58.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 63.0, 62.0, 63.0, 63.0, 63.0, 62.0, 63.0], "value": 62.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 81.0, 79.0, 80.0, 79.0, 80.0, 81.0, 82.0, 81.0], "value": 80.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 131.0, 130.0, 130.0, 129.0, 125.0, 129.0, 127.0, 194.0, 138.0], "value": 136.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 167.0, 167.0, 166.0, 167.0, 164.0, 168.0, 173.0, 165.0, 166.0], "value": 167.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 66.0, 69.0, 68.0, 66.0, 66.0, 75.0, 65.0], "value": 67.6, "unit": "score"}], "name": "kraken", "value": 1548.3, "alertThreshold": 2.0}]} 04:21:00 INFO - Return code: 0 04:21:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 04:21:00 ERROR - # TBPL SUCCESS # 04:21:00 INFO - Running post-action listener: _resource_record_post_action 04:21:00 INFO - Running post-run listener: _resource_record_post_run 04:21:01 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 7901184; Write bytes: 430907392; Read time: 1228; Write time: 256796 04:21:01 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 149336064; Read time: 0; Write time: 108724 04:21:01 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 6139904; Write bytes: 281571328; Read time: 1172; Write time: 148072 04:21:01 INFO - Running post-run listener: _upload_blobber_files 04:21:01 INFO - Blob upload gear active. 04:21:01 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 04:21:01 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 04:21:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 04:21:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 04:21:02 INFO - (blobuploader) - INFO - Open directory for files ... 04:21:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:21:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:21:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:21:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:21:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:21:02 INFO - (blobuploader) - INFO - Done attempting. 04:21:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 04:21:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:21:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:21:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:21:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:21:03 INFO - (blobuploader) - INFO - Done attempting. 04:21:03 INFO - (blobuploader) - INFO - Iteration through files over. 04:21:03 INFO - Return code: 0 04:21:03 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 04:21:03 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 04:21:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/732a876f88c5b29d7c02c0984119663bb7c64a344504ba85a6f5176bf46fb773e725e3ce79c0dd7e288db920fe96da376065c6a8d05db85613ae340564df8b98", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6c9e807cf82438ae33e4710a5dc2e657b26eef580435e532cf3a319da1a2a21e1601a9232e07957912a482fd91b3039ce2f49137e1929f43c6c23daa7b4e97a5"} 04:21:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 04:21:03 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 04:21:03 INFO - Contents: 04:21:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/732a876f88c5b29d7c02c0984119663bb7c64a344504ba85a6f5176bf46fb773e725e3ce79c0dd7e288db920fe96da376065c6a8d05db85613ae340564df8b98", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6c9e807cf82438ae33e4710a5dc2e657b26eef580435e532cf3a319da1a2a21e1601a9232e07957912a482fd91b3039ce2f49137e1929f43c6c23daa7b4e97a5"} 04:21:03 INFO - Running post-run listener: copy_logs_to_upload_dir 04:21:03 INFO - Copying logs to upload dir... 04:21:03 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 04:21:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.511272 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-04-12 04:21:03.514405) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-12 04:21:03.517679) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1460455452.253405-1676173409 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/732a876f88c5b29d7c02c0984119663bb7c64a344504ba85a6f5176bf46fb773e725e3ce79c0dd7e288db920fe96da376065c6a8d05db85613ae340564df8b98", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6c9e807cf82438ae33e4710a5dc2e657b26eef580435e532cf3a319da1a2a21e1601a9232e07957912a482fd91b3039ce2f49137e1929f43c6c23daa7b4e97a5"} build_url:https://queue.taskcluster.net/v1/task/bIE4V5U-S9GMExek4Am7hQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011272 build_url: 'https://queue.taskcluster.net/v1/task/bIE4V5U-S9GMExek4Am7hQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/732a876f88c5b29d7c02c0984119663bb7c64a344504ba85a6f5176bf46fb773e725e3ce79c0dd7e288db920fe96da376065c6a8d05db85613ae340564df8b98", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6c9e807cf82438ae33e4710a5dc2e657b26eef580435e532cf3a319da1a2a21e1601a9232e07957912a482fd91b3039ce2f49137e1929f43c6c23daa7b4e97a5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-12 04:21:03.542468) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 04:21:03.542798) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1460455452.253405-1676173409 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004497 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 04:21:03.627387) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-12 04:21:03.627713) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-12 04:21:03.628525) ========= ========= Total master_lag: 0.23 =========