builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-068 starttime: 1460037835.31 results: success (0) buildid: 20160407043123 builduid: 4f09fdfd642c45dfae0ef3b28017e806 revision: b6683e141c47c022598c0caac3ea8ba8c6236d42 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-07 07:03:55.312594) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-07 07:03:55.313051) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-07 07:03:55.313335) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=97facb8ba2ac28944cc45e6b000001d4-1460037833.121550-149164480 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004524 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-07 07:03:55.330002) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-07 07:03:55.330316) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-07 07:03:55.342501) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 07:03:55.342924) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=97facb8ba2ac28944cc45e6b000001d4-1460037833.121550-149164480 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004599 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 07:03:55.392600) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-07 07:03:55.392923) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-07 07:03:55.393325) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 07:03:55.393607) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=97facb8ba2ac28944cc45e6b000001d4-1460037833.121550-149164480 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-07 07:03:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 96.6M=0s 2016-04-07 07:03:55 (96.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.131164 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 07:03:55.538105) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 07:03:55.538470) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=97facb8ba2ac28944cc45e6b000001d4-1460037833.121550-149164480 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021419 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 07:03:55.588665) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 07:03:55.589010) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b6683e141c47c022598c0caac3ea8ba8c6236d42 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev b6683e141c47c022598c0caac3ea8ba8c6236d42 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=97facb8ba2ac28944cc45e6b000001d4-1460037833.121550-149164480 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-07 07:03:55,880 truncating revision to first 12 chars 2016-04-07 07:03:55,880 Setting DEBUG logging. 2016-04-07 07:03:55,880 attempt 1/10 2016-04-07 07:03:55,880 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b6683e141c47?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-07 07:03:56,124 unpacking tar archive at: mozilla-central-b6683e141c47/testing/mozharness/ program finished with exit code 0 elapsedTime=0.501171 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 07:03:56.103442) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-07 07:03:56.103829) ========= echo b6683e141c47c022598c0caac3ea8ba8c6236d42 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'b6683e141c47c022598c0caac3ea8ba8c6236d42'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=97facb8ba2ac28944cc45e6b000001d4-1460037833.121550-149164480 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False b6683e141c47c022598c0caac3ea8ba8c6236d42 program finished with exit code 0 elapsedTime=0.003835 script_repo_revision: 'b6683e141c47c022598c0caac3ea8ba8c6236d42' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-07 07:03:56.151952) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-07 07:03:56.152257) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-07 07:03:56.162479) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-04-07 07:03:56.162798) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=97facb8ba2ac28944cc45e6b000001d4-1460037833.121550-149164480 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:03:56 INFO - MultiFileLogger online at 20160407 07:03:56 in /builds/slave/test-pgo 07:03:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:03:56 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 07:03:56 INFO - {'append_to_log': False, 07:03:56 INFO - 'base_work_dir': '/builds/slave/test-pgo', 07:03:56 INFO - 'blob_upload_branch': 'Firefox', 07:03:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 07:03:56 INFO - 'branch': 'Firefox', 07:03:56 INFO - 'buildbot_json_path': 'buildprops.json', 07:03:56 INFO - 'config_files': ('talos/linux_config.py',), 07:03:56 INFO - 'default_actions': ('clobber', 07:03:56 INFO - 'read-buildbot-config', 07:03:56 INFO - 'download-and-extract', 07:03:56 INFO - 'populate-webroot', 07:03:56 INFO - 'create-virtualenv', 07:03:56 INFO - 'install', 07:03:56 INFO - 'run-tests'), 07:03:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:03:56 INFO - 'download_minidump_stackwalk': True, 07:03:56 INFO - 'download_symbols': 'ondemand', 07:03:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:03:56 INFO - 'tooltool.py': '/tools/tooltool.py', 07:03:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:03:56 INFO - '/tools/misc-python/virtualenv.py')}, 07:03:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:03:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:03:56 INFO - 'installer_path': 'installer.exe', 07:03:56 INFO - 'log_level': 'info', 07:03:56 INFO - 'log_name': 'talos', 07:03:56 INFO - 'log_to_console': True, 07:03:56 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:03:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:03:56 INFO - 'opt_config_files': (), 07:03:56 INFO - 'pip_index': False, 07:03:56 INFO - 'sps_profile': False, 07:03:56 INFO - 'sps_profile_interval': 0, 07:03:56 INFO - 'suite': 'dromaeojs', 07:03:56 INFO - 'system_bits': '32', 07:03:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:03:56 INFO - 'title': 'talos-linux64-ix-068', 07:03:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:03:56 INFO - 'use_talos_json': True, 07:03:56 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 07:03:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:03:56 INFO - 'work_dir': 'build'} 07:03:56 INFO - ##### 07:03:56 INFO - ##### Running clobber step. 07:03:56 INFO - ##### 07:03:56 INFO - Running pre-action listener: _resource_record_pre_action 07:03:56 INFO - Running main action method: clobber 07:03:56 INFO - rmtree: /builds/slave/test-pgo/build 07:03:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 07:03:57 INFO - Running post-action listener: _resource_record_post_action 07:03:57 INFO - ##### 07:03:57 INFO - ##### Running read-buildbot-config step. 07:03:57 INFO - ##### 07:03:57 INFO - Running pre-action listener: _resource_record_pre_action 07:03:57 INFO - Running main action method: read_buildbot_config 07:03:57 INFO - Using buildbot properties: 07:03:57 INFO - { 07:03:57 INFO - "project": "", 07:03:57 INFO - "product": "firefox", 07:03:57 INFO - "script_repo_revision": "production", 07:03:57 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:03:57 INFO - "repository": "", 07:03:57 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 07:03:57 INFO - "buildid": "20160407043123", 07:03:57 INFO - "pgo_build": "True", 07:03:57 INFO - "basedir": "/builds/slave/test-pgo", 07:03:57 INFO - "buildnumber": 733, 07:03:57 INFO - "slavename": "talos-linux64-ix-068", 07:03:57 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:03:57 INFO - "platform": "ubuntu64_hw", 07:03:57 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 07:03:57 INFO - "branch": "mozilla-central", 07:03:57 INFO - "repo_path": "mozilla-central", 07:03:57 INFO - "revision": "b6683e141c47c022598c0caac3ea8ba8c6236d42", 07:03:57 INFO - "stage_platform": "linux64-pgo", 07:03:57 INFO - "builduid": "4f09fdfd642c45dfae0ef3b28017e806", 07:03:57 INFO - "slavebuilddir": "test" 07:03:57 INFO - } 07:03:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/YhA9EenXQnG79snKGuSYig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 07:03:57 INFO - Running post-action listener: _resource_record_post_action 07:03:57 INFO - ##### 07:03:57 INFO - ##### Running download-and-extract step. 07:03:57 INFO - ##### 07:03:57 INFO - Running pre-action listener: _resource_record_pre_action 07:03:57 INFO - Running main action method: download_and_extract 07:03:57 INFO - mkdir: /builds/slave/test-pgo/build/tests 07:03:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:03:57 INFO - https://queue.taskcluster.net/v1/task/YhA9EenXQnG79snKGuSYig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:03:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YhA9EenXQnG79snKGuSYig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:03:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YhA9EenXQnG79snKGuSYig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:03:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YhA9EenXQnG79snKGuSYig/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 07:03:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YhA9EenXQnG79snKGuSYig/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 07:04:00 INFO - Downloaded 1361 bytes. 07:04:00 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:04:00 INFO - Using the following test package requirements: 07:04:00 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 07:04:00 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:04:00 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:04:00 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:04:00 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:04:00 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:04:00 INFO - u'jsshell-linux-x86_64.zip'], 07:04:00 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:04:00 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:04:00 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 07:04:00 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:04:00 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:04:00 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:04:00 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:04:00 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:04:00 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:04:00 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:04:00 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:04:00 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:04:00 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')]} 07:04:00 INFO - https://queue.taskcluster.net/v1/task/YhA9EenXQnG79snKGuSYig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:04:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YhA9EenXQnG79snKGuSYig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:04:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YhA9EenXQnG79snKGuSYig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:04:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YhA9EenXQnG79snKGuSYig/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 07:04:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YhA9EenXQnG79snKGuSYig/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 07:04:02 INFO - Downloaded 23714533 bytes. 07:04:02 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'] 07:04:02 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 07:04:03 INFO - Return code: 0 07:04:03 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 07:04: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')]} 07:04:03 INFO - https://queue.taskcluster.net/v1/task/YhA9EenXQnG79snKGuSYig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:04:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YhA9EenXQnG79snKGuSYig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:04:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YhA9EenXQnG79snKGuSYig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:04:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YhA9EenXQnG79snKGuSYig/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 07:04:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YhA9EenXQnG79snKGuSYig/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 07:04:05 INFO - Downloaded 23714533 bytes. 07:04:05 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'] 07:04:05 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 07:04:07 INFO - Return code: 0 07:04:07 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')]} 07:04:07 INFO - https://queue.taskcluster.net/v1/task/YhA9EenXQnG79snKGuSYig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:04:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YhA9EenXQnG79snKGuSYig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:04:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YhA9EenXQnG79snKGuSYig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:04:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YhA9EenXQnG79snKGuSYig/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 07:04:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YhA9EenXQnG79snKGuSYig/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 07:04:08 INFO - Downloaded 10847693 bytes. 07:04:08 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'] 07:04:08 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 07:04:08 INFO - Return code: 0 07:04:08 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')]} 07:04:08 INFO - https://queue.taskcluster.net/v1/task/YhA9EenXQnG79snKGuSYig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:04:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YhA9EenXQnG79snKGuSYig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:04:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YhA9EenXQnG79snKGuSYig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:04:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YhA9EenXQnG79snKGuSYig/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 07:04:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YhA9EenXQnG79snKGuSYig/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 07:04:10 INFO - Downloaded 57869901 bytes. 07:04:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YhA9EenXQnG79snKGuSYig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:04:10 INFO - mkdir: /builds/slave/test-pgo/properties 07:04:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 07:04:10 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 07:04:10 INFO - Contents: 07:04:10 INFO - build_url:https://queue.taskcluster.net/v1/task/YhA9EenXQnG79snKGuSYig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:04:11 INFO - Running post-action listener: _resource_record_post_action 07:04:11 INFO - Running post-action listener: set_extra_try_arguments 07:04:11 INFO - ##### 07:04:11 INFO - ##### Running populate-webroot step. 07:04:11 INFO - ##### 07:04:11 INFO - Running pre-action listener: _resource_record_pre_action 07:04:11 INFO - Running main action method: populate_webroot 07:04:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:04:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:04:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:04:11 INFO - '--tppagecycles', 07:04:11 INFO - '7'], 07:04:11 INFO - 'tests': ['tsvgm']}}, 07:04:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:04:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:04:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:04:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:04:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:04:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:04:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:04:11 INFO - 'talos_options': ['--disable-e10s'], 07:04:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:04:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:04:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:04:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:04:11 INFO - 'talos_options': ['--disable-e10s'], 07:04:11 INFO - 'tests': ['damp', 'tps']}, 07:04:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:04:11 INFO - 'tests': ['damp', 'tps']}, 07:04:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:04:11 INFO - 'tests': ['dromaeo_dom']}, 07:04:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:04:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:04:11 INFO - 'tests': ['a11yr', 07:04:11 INFO - 'ts_paint', 07:04:11 INFO - 'tpaint', 07:04:11 INFO - 'sessionrestore', 07:04:11 INFO - 'sessionrestore_no_auto_restore', 07:04:11 INFO - 'tabpaint']}, 07:04:11 INFO - 'other-e10s': {'tests': ['a11yr', 07:04:11 INFO - 'ts_paint', 07:04:11 INFO - 'tpaint', 07:04:11 INFO - 'sessionrestore', 07:04:11 INFO - 'sessionrestore_no_auto_restore', 07:04:11 INFO - 'tabpaint']}, 07:04:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:04:11 INFO - 'ts_paint', 07:04:11 INFO - 'tpaint', 07:04:11 INFO - 'sessionrestore', 07:04:11 INFO - 'sessionrestore_no_auto_restore', 07:04:11 INFO - 'tabpaint']}, 07:04:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:04:11 INFO - 'ts_paint', 07:04:11 INFO - 'tpaint', 07:04:11 INFO - 'sessionrestore', 07:04:11 INFO - 'sessionrestore_no_auto_restore', 07:04:11 INFO - 'tabpaint']}, 07:04:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:04:11 INFO - 'tests': ['a11yr', 07:04:11 INFO - 'ts_paint', 07:04:11 INFO - 'tpaint', 07:04:11 INFO - 'sessionrestore', 07:04:11 INFO - 'sessionrestore_no_auto_restore', 07:04:11 INFO - 'tabpaint']}, 07:04:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:04:11 INFO - 'tests': ['a11yr', 07:04:11 INFO - 'ts_paint', 07:04:11 INFO - 'tpaint', 07:04:11 INFO - 'sessionrestore', 07:04:11 INFO - 'sessionrestore_no_auto_restore', 07:04:11 INFO - 'tabpaint']}, 07:04:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:04:11 INFO - 'tests': ['tsvgx', 07:04:11 INFO - 'tsvgr_opacity', 07:04:11 INFO - 'tart', 07:04:11 INFO - 'tscrollx', 07:04:11 INFO - 'cart']}, 07:04:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:04:11 INFO - 'tsvgr_opacity', 07:04:11 INFO - 'tart', 07:04:11 INFO - 'tscrollx', 07:04:11 INFO - 'cart']}, 07:04:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:04:11 INFO - 'talos_options': ['--disable-e10s'], 07:04:11 INFO - 'tests': ['tp5o']}, 07:04:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:04:11 INFO - 'tests': ['tp5o']}, 07:04:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:04:11 INFO - 'talos_options': ['--disable-e10s', 07:04:11 INFO - '--xperf_path', 07:04:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:04:11 INFO - 'tests': ['tp5n']}, 07:04:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:04:11 INFO - 'talos_options': ['--xperf_path', 07:04:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:04:11 INFO - 'tests': ['tp5n']}}, 07:04:11 INFO - 'talos.zip': {'path': '', 07:04:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:04:11 INFO - Running post-action listener: _resource_record_post_action 07:04:11 INFO - ##### 07:04:11 INFO - ##### Running create-virtualenv step. 07:04:11 INFO - ##### 07:04:11 INFO - Running pre-action listener: _resource_record_pre_action 07:04:11 INFO - Running main action method: create_virtualenv 07:04:11 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 07:04:11 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 07:04:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 07:04:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:04:11 INFO - Using real prefix '/usr' 07:04:11 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 07:04:11 INFO - Installing distribute.............................................................................................................................................................................................done. 07:04:13 INFO - Installing pip.................done. 07:04:13 INFO - Return code: 0 07:04:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 07:04:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:04:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:04:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:04:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:04:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:13 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 0x7f995d99bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x227d6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22781d0>, '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 0x227b750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x227bbe0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1460037833.121550-149164480', '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 07:04:13 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 07:04:13 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 07:04:13 INFO - Using env: {'DISPLAY': ':0', 07:04:13 INFO - 'HOME': '/home/cltbld', 07:04:13 INFO - 'LANG': 'en_US.UTF-8', 07:04:13 INFO - 'LANGUAGE': 'en_US:en', 07:04:13 INFO - 'LOGNAME': 'cltbld', 07:04:13 INFO - 'MAIL': '/var/mail/cltbld', 07:04:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:13 INFO - 'MOZ_NO_REMOTE': '1', 07:04:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:13 INFO - 'NO_EM_RESTART': '1', 07:04:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:04:13 INFO - 'PWD': '/builds/slave/test-pgo', 07:04:13 INFO - 'SHELL': '/bin/bash', 07:04:13 INFO - 'SHLVL': '1', 07:04:13 INFO - 'TERM': 'linux', 07:04:13 INFO - 'TMOUT': '86400', 07:04:13 INFO - 'USER': 'cltbld', 07:04:13 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1460037833.121550-149164480', 07:04:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:13 INFO - '_': '/tools/buildbot/bin/python'} 07:04:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:04:13 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 07:04:13 INFO - Cleaning up... 07:04:13 INFO - Return code: 0 07:04:13 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 07:04:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:04:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:04:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:04:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:04:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:13 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 0x7f995d99bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x227d6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22781d0>, '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 0x227b750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x227bbe0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1460037833.121550-149164480', '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 07:04:13 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 07:04:13 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 07:04:13 INFO - Using env: {'DISPLAY': ':0', 07:04:13 INFO - 'HOME': '/home/cltbld', 07:04:13 INFO - 'LANG': 'en_US.UTF-8', 07:04:13 INFO - 'LANGUAGE': 'en_US:en', 07:04:13 INFO - 'LOGNAME': 'cltbld', 07:04:13 INFO - 'MAIL': '/var/mail/cltbld', 07:04:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:13 INFO - 'MOZ_NO_REMOTE': '1', 07:04:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:13 INFO - 'NO_EM_RESTART': '1', 07:04:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:04:13 INFO - 'PWD': '/builds/slave/test-pgo', 07:04:13 INFO - 'SHELL': '/bin/bash', 07:04:13 INFO - 'SHLVL': '1', 07:04:13 INFO - 'TERM': 'linux', 07:04:13 INFO - 'TMOUT': '86400', 07:04:13 INFO - 'USER': 'cltbld', 07:04:13 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1460037833.121550-149164480', 07:04:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:13 INFO - '_': '/tools/buildbot/bin/python'} 07:04:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:04:14 INFO - Downloading/unpacking psutil>=0.7.1 07:04:14 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 07:04:14 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 07:04:14 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 07:04:14 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 07:04:14 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 07:04:14 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 07:04:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 07:04:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:04:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:04:16 INFO - Installing collected packages: psutil 07:04:16 INFO - Running setup.py install for psutil 07:04:16 INFO - building 'psutil._psutil_linux' extension 07:04:16 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 07:04:16 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 07:04:16 INFO - building 'psutil._psutil_posix' extension 07:04:16 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 07:04:16 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 07:04:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:04:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:04:16 INFO - Successfully installed psutil 07:04:16 INFO - Cleaning up... 07:04:16 INFO - Return code: 0 07:04:16 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 07:04:16 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')]} 07:04:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:04:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:16 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')]} 07:04:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:04:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:16 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 0x7f995d99bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x227d6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22781d0>, '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 0x227b750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x227bbe0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1460037833.121550-149164480', '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 07:04:16 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 07:04:16 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 07:04:16 INFO - Using env: {'DISPLAY': ':0', 07:04:16 INFO - 'HOME': '/home/cltbld', 07:04:16 INFO - 'LANG': 'en_US.UTF-8', 07:04:16 INFO - 'LANGUAGE': 'en_US:en', 07:04:16 INFO - 'LOGNAME': 'cltbld', 07:04:16 INFO - 'MAIL': '/var/mail/cltbld', 07:04:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:16 INFO - 'MOZ_NO_REMOTE': '1', 07:04:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:16 INFO - 'NO_EM_RESTART': '1', 07:04:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:04:16 INFO - 'PWD': '/builds/slave/test-pgo', 07:04:16 INFO - 'SHELL': '/bin/bash', 07:04:16 INFO - 'SHLVL': '1', 07:04:16 INFO - 'TERM': 'linux', 07:04:16 INFO - 'TMOUT': '86400', 07:04:16 INFO - 'USER': 'cltbld', 07:04:16 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1460037833.121550-149164480', 07:04:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:16 INFO - '_': '/tools/buildbot/bin/python'} 07:04:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:04:16 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:04:16 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 07:04:16 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 07:04:16 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 07:04:16 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 07:04:16 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 07:04:16 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 07:04:18 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:04:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:04:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:04:18 INFO - Installing collected packages: mozsystemmonitor 07:04:18 INFO - Running setup.py install for mozsystemmonitor 07:04:18 INFO - Successfully installed mozsystemmonitor 07:04:18 INFO - Cleaning up... 07:04:18 INFO - Return code: 0 07:04:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 07:04: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')]} 07:04:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:04:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04: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')]} 07:04:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:04:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:18 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 0x7f995d99bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x227d6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22781d0>, '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 0x227b750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x227bbe0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1460037833.121550-149164480', '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 07:04:18 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 07:04:18 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 07:04:18 INFO - Using env: {'DISPLAY': ':0', 07:04:18 INFO - 'HOME': '/home/cltbld', 07:04:18 INFO - 'LANG': 'en_US.UTF-8', 07:04:18 INFO - 'LANGUAGE': 'en_US:en', 07:04:18 INFO - 'LOGNAME': 'cltbld', 07:04:18 INFO - 'MAIL': '/var/mail/cltbld', 07:04:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:18 INFO - 'MOZ_NO_REMOTE': '1', 07:04:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:18 INFO - 'NO_EM_RESTART': '1', 07:04:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:04:18 INFO - 'PWD': '/builds/slave/test-pgo', 07:04:18 INFO - 'SHELL': '/bin/bash', 07:04:18 INFO - 'SHLVL': '1', 07:04:18 INFO - 'TERM': 'linux', 07:04:18 INFO - 'TMOUT': '86400', 07:04:18 INFO - 'USER': 'cltbld', 07:04:18 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1460037833.121550-149164480', 07:04:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:18 INFO - '_': '/tools/buildbot/bin/python'} 07:04:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:04:19 INFO - Downloading/unpacking blobuploader==1.2.4 07:04:19 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 07:04:19 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 07:04:19 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 07:04:19 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 07:04:19 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 07:04:19 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 07:04:20 INFO - Downloading blobuploader-1.2.4.tar.gz 07:04:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:04:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:04:20 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 07:04:20 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 07:04:20 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 07:04:20 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 07:04:20 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 07:04:20 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 07:04:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 07:04:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:04:21 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 07:04:21 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 07:04:21 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 07:04:21 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 07:04:21 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 07:04:21 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 07:04:21 INFO - Downloading docopt-0.6.1.tar.gz 07:04:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 07:04:21 INFO - Installing collected packages: blobuploader, requests, docopt 07:04:21 INFO - Running setup.py install for blobuploader 07:04:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:04:21 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 07:04:21 INFO - Running setup.py install for requests 07:04:22 INFO - Running setup.py install for docopt 07:04:22 INFO - Successfully installed blobuploader requests docopt 07:04:22 INFO - Cleaning up... 07:04:22 INFO - Return code: 0 07:04:22 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:04: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')]} 07:04:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:04:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04: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')]} 07:04:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:04:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:22 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 0x7f995d99bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x227d6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22781d0>, '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 0x227b750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x227bbe0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1460037833.121550-149164480', '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 07:04:22 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 07:04:22 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 07:04:22 INFO - Using env: {'DISPLAY': ':0', 07:04:22 INFO - 'HOME': '/home/cltbld', 07:04:22 INFO - 'LANG': 'en_US.UTF-8', 07:04:22 INFO - 'LANGUAGE': 'en_US:en', 07:04:22 INFO - 'LOGNAME': 'cltbld', 07:04:22 INFO - 'MAIL': '/var/mail/cltbld', 07:04:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:22 INFO - 'MOZ_NO_REMOTE': '1', 07:04:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:22 INFO - 'NO_EM_RESTART': '1', 07:04:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:04:22 INFO - 'PWD': '/builds/slave/test-pgo', 07:04:22 INFO - 'SHELL': '/bin/bash', 07:04:22 INFO - 'SHLVL': '1', 07:04:22 INFO - 'TERM': 'linux', 07:04:22 INFO - 'TMOUT': '86400', 07:04:22 INFO - 'USER': 'cltbld', 07:04:22 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1460037833.121550-149164480', 07:04:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:22 INFO - '_': '/tools/buildbot/bin/python'} 07:04:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:04:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:04:22 INFO - Running setup.py (path:/tmp/pip-N670lN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:04:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:04:22 INFO - Running setup.py (path:/tmp/pip-QxP2sd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:04:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:04:22 INFO - Running setup.py (path:/tmp/pip-WBsoUh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:04:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:04:22 INFO - Running setup.py (path:/tmp/pip-Od3lS0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:04:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:04:22 INFO - Running setup.py (path:/tmp/pip-QcGOLh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:04:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:04:22 INFO - Running setup.py (path:/tmp/pip-quAXNz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:04:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:04:22 INFO - Running setup.py (path:/tmp/pip-IsHGSa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:04:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:04:22 INFO - Running setup.py (path:/tmp/pip-DSjUiB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:04:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:04:23 INFO - Running setup.py (path:/tmp/pip-Kr54qz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:04:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:04:23 INFO - Running setup.py (path:/tmp/pip-LYvS26-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:04:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:04:23 INFO - Running setup.py (path:/tmp/pip-wbxM8x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:04:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:04:23 INFO - Running setup.py (path:/tmp/pip-BGyzeH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:04:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:04:23 INFO - Running setup.py (path:/tmp/pip-o_6bGE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:04:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:04:23 INFO - Running setup.py (path:/tmp/pip-dXZXMV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:04:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:04:23 INFO - Running setup.py (path:/tmp/pip-VqOKJo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:04:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:04:23 INFO - Running setup.py (path:/tmp/pip-a7kZJV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:04:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:04:23 INFO - Running setup.py (path:/tmp/pip-RlPER8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:04:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:04:23 INFO - Running setup.py install for manifestparser 07:04:23 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 07:04:23 INFO - Running setup.py install for mozcrash 07:04:23 INFO - Running setup.py install for mozdebug 07:04:24 INFO - Running setup.py install for mozdevice 07:04:24 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 07:04:24 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 07:04:24 INFO - Running setup.py install for mozfile 07:04:24 INFO - Running setup.py install for mozhttpd 07:04:24 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 07:04:24 INFO - Running setup.py install for mozinfo 07:04:24 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 07:04:24 INFO - Running setup.py install for mozInstall 07:04:24 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 07:04:24 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 07:04:24 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 07:04:24 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 07:04:24 INFO - Running setup.py install for mozleak 07:04:24 INFO - Running setup.py install for mozlog 07:04:24 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 07:04:24 INFO - Running setup.py install for moznetwork 07:04:24 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 07:04:24 INFO - Running setup.py install for mozprocess 07:04:24 INFO - Running setup.py install for mozprofile 07:04:25 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 07:04:25 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 07:04:25 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 07:04:25 INFO - Running setup.py install for mozrunner 07:04:25 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 07:04:25 INFO - Running setup.py install for mozscreenshot 07:04:25 INFO - Running setup.py install for moztest 07:04:25 INFO - Running setup.py install for mozversion 07:04:25 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 07:04:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:04:25 INFO - Cleaning up... 07:04:25 INFO - Return code: 0 07:04:25 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:04:25 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')]} 07:04:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:04:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:25 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')]} 07:04:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:04:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:25 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 0x7f995d99bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x227d6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22781d0>, '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 0x227b750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x227bbe0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1460037833.121550-149164480', '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 07:04:25 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 07:04:25 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 07:04:25 INFO - Using env: {'DISPLAY': ':0', 07:04:25 INFO - 'HOME': '/home/cltbld', 07:04:25 INFO - 'LANG': 'en_US.UTF-8', 07:04:25 INFO - 'LANGUAGE': 'en_US:en', 07:04:25 INFO - 'LOGNAME': 'cltbld', 07:04:25 INFO - 'MAIL': '/var/mail/cltbld', 07:04:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:25 INFO - 'MOZ_NO_REMOTE': '1', 07:04:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:25 INFO - 'NO_EM_RESTART': '1', 07:04:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:04:25 INFO - 'PWD': '/builds/slave/test-pgo', 07:04:25 INFO - 'SHELL': '/bin/bash', 07:04:25 INFO - 'SHLVL': '1', 07:04:25 INFO - 'TERM': 'linux', 07:04:25 INFO - 'TMOUT': '86400', 07:04:25 INFO - 'USER': 'cltbld', 07:04:25 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1460037833.121550-149164480', 07:04:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:25 INFO - '_': '/tools/buildbot/bin/python'} 07:04:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:04:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:04:25 INFO - Running setup.py (path:/tmp/pip-k2tK1G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:04:25 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)) 07:04:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:04:25 INFO - Running setup.py (path:/tmp/pip-TzJLLz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:04:25 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)) 07:04:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:04:25 INFO - Running setup.py (path:/tmp/pip-kFCpHN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:04:25 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)) 07:04:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:04:25 INFO - Running setup.py (path:/tmp/pip-KA052C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:04:26 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)) 07:04:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:04:26 INFO - Running setup.py (path:/tmp/pip-y3bbO6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:04:26 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)) 07:04:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:04:26 INFO - Running setup.py (path:/tmp/pip-N15f2H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:04:26 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)) 07:04:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:04:26 INFO - Running setup.py (path:/tmp/pip-4I6TLE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:04:26 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)) 07:04:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:04:26 INFO - Running setup.py (path:/tmp/pip-EgLsHQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:04:26 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)) 07:04:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:04:26 INFO - Running setup.py (path:/tmp/pip-o0uADE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:04:26 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)) 07:04:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:04:26 INFO - Running setup.py (path:/tmp/pip-BPgwKM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:04:26 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)) 07:04:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:04:26 INFO - Running setup.py (path:/tmp/pip-DlyZZf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:04:26 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)) 07:04:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:04:26 INFO - Running setup.py (path:/tmp/pip-8TCidh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:04:26 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)) 07:04:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:04:26 INFO - Running setup.py (path:/tmp/pip-WLJo1X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:04:26 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)) 07:04:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:04:26 INFO - Running setup.py (path:/tmp/pip-ZcLzWJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:04:26 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)) 07:04:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:04:26 INFO - Running setup.py (path:/tmp/pip-aRIca0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:04:26 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)) 07:04:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:04:26 INFO - Running setup.py (path:/tmp/pip-nkvPMA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:04:26 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)) 07:04:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:04:26 INFO - Running setup.py (path:/tmp/pip-EcbX0p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:04:26 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)) 07:04:26 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)) 07:04:26 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)) 07:04:26 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)) 07:04:26 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)) 07:04:26 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)) 07:04:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 07:04:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:04:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:04:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:28 INFO - Downloading blessings-1.6.tar.gz 07:04:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 07:04:28 INFO - Installing collected packages: blessings 07:04:28 INFO - Running setup.py install for blessings 07:04:29 INFO - Successfully installed blessings 07:04:29 INFO - Cleaning up... 07:04:29 INFO - Return code: 0 07:04:29 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 07:04:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:04:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:04:29 INFO - Reading from file tmpfile_stdout 07:04:29 INFO - Current package versions: 07:04:29 INFO - argparse == 1.2.1 07:04:29 INFO - blessings == 1.6 07:04:29 INFO - blobuploader == 1.2.4 07:04:29 INFO - docopt == 0.6.1 07:04:29 INFO - manifestparser == 1.1 07:04:29 INFO - mozInstall == 1.12 07:04:29 INFO - mozcrash == 0.17 07:04:29 INFO - mozdebug == 0.1 07:04:29 INFO - mozdevice == 0.48 07:04:29 INFO - mozfile == 1.2 07:04:29 INFO - mozhttpd == 0.7 07:04:29 INFO - mozinfo == 0.9 07:04:29 INFO - mozleak == 0.1 07:04:29 INFO - mozlog == 3.1 07:04:29 INFO - moznetwork == 0.27 07:04:29 INFO - mozprocess == 0.22 07:04:29 INFO - mozprofile == 0.28 07:04:29 INFO - mozrunner == 6.11 07:04:29 INFO - mozscreenshot == 0.1 07:04:29 INFO - mozsystemmonitor == 0.0 07:04:29 INFO - moztest == 0.7 07:04:29 INFO - mozversion == 1.4 07:04:29 INFO - psutil == 3.1.1 07:04:29 INFO - requests == 1.2.3 07:04:29 INFO - wsgiref == 0.1.2 07:04:29 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:04:29 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')]} 07:04:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:04:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:29 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')]} 07:04:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:04:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:29 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 0x7f995d99bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x227d6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22781d0>, '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 0x227b750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x227bbe0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1460037833.121550-149164480', '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 07:04:29 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 07:04:29 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 07:04:29 INFO - Using env: {'DISPLAY': ':0', 07:04:29 INFO - 'HOME': '/home/cltbld', 07:04:29 INFO - 'LANG': 'en_US.UTF-8', 07:04:29 INFO - 'LANGUAGE': 'en_US:en', 07:04:29 INFO - 'LOGNAME': 'cltbld', 07:04:29 INFO - 'MAIL': '/var/mail/cltbld', 07:04:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:29 INFO - 'MOZ_NO_REMOTE': '1', 07:04:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:29 INFO - 'NO_EM_RESTART': '1', 07:04:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:04:29 INFO - 'PWD': '/builds/slave/test-pgo', 07:04:29 INFO - 'SHELL': '/bin/bash', 07:04:29 INFO - 'SHLVL': '1', 07:04:29 INFO - 'TERM': 'linux', 07:04:29 INFO - 'TMOUT': '86400', 07:04:29 INFO - 'USER': 'cltbld', 07:04:29 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1460037833.121550-149164480', 07:04:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:29 INFO - '_': '/tools/buildbot/bin/python'} 07:04:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:04:29 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)) 07:04:29 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)) 07:04:29 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)) 07:04:29 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)) 07:04:29 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)) 07:04:29 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)) 07:04:29 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)) 07:04:29 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)) 07:04:29 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)) 07:04:29 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)) 07:04:29 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)) 07:04:29 INFO - Cleaning up... 07:04:29 INFO - Return code: 0 07:04:29 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 07:04:29 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')]} 07:04:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:04:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:29 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')]} 07:04:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:04:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:29 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 0x7f995d99bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x227d6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22781d0>, '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 0x227b750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x227bbe0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1460037833.121550-149164480', '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 07:04:29 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 07:04:29 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 07:04:29 INFO - Using env: {'DISPLAY': ':0', 07:04:29 INFO - 'HOME': '/home/cltbld', 07:04:29 INFO - 'LANG': 'en_US.UTF-8', 07:04:29 INFO - 'LANGUAGE': 'en_US:en', 07:04:29 INFO - 'LOGNAME': 'cltbld', 07:04:29 INFO - 'MAIL': '/var/mail/cltbld', 07:04:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:29 INFO - 'MOZ_NO_REMOTE': '1', 07:04:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:29 INFO - 'NO_EM_RESTART': '1', 07:04:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:04:29 INFO - 'PWD': '/builds/slave/test-pgo', 07:04:29 INFO - 'SHELL': '/bin/bash', 07:04:29 INFO - 'SHLVL': '1', 07:04:29 INFO - 'TERM': 'linux', 07:04:29 INFO - 'TMOUT': '86400', 07:04:29 INFO - 'USER': 'cltbld', 07:04:29 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1460037833.121550-149164480', 07:04:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:29 INFO - '_': '/tools/buildbot/bin/python'} 07:04:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:04:29 INFO - Downloading/unpacking jsonschema 07:04:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:04:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:04:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:04:31 INFO - Downloading/unpacking functools32 (from jsonschema) 07:04:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:04:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:04:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:31 INFO - Downloading functools32-3.2.3-2.tar.gz 07:04:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 07:04:31 INFO - warning: no files found matching '*.txt' 07:04:31 INFO - no previously-included directories found matching 'build' 07:04:31 INFO - no previously-included directories found matching 'dist' 07:04:31 INFO - no previously-included directories found matching '.git*' 07:04:31 INFO - Installing collected packages: jsonschema, functools32 07:04:31 INFO - Running setup.py install for functools32 07:04:32 INFO - warning: no files found matching '*.txt' 07:04:32 INFO - no previously-included directories found matching 'build' 07:04:32 INFO - no previously-included directories found matching 'dist' 07:04:32 INFO - no previously-included directories found matching '.git*' 07:04:32 INFO - Successfully installed jsonschema functools32 07:04:32 INFO - Cleaning up... 07:04:32 INFO - Return code: 0 07:04:32 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 07:04:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:04:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:04:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:04:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:04:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:32 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f995d99bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x227d6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22781d0>, '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 0x227b750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x227bbe0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1460037833.121550-149164480', '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 07:04:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 07:04:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:04:32 INFO - Using env: {'DISPLAY': ':0', 07:04:32 INFO - 'HOME': '/home/cltbld', 07:04:32 INFO - 'LANG': 'en_US.UTF-8', 07:04:32 INFO - 'LANGUAGE': 'en_US:en', 07:04:32 INFO - 'LOGNAME': 'cltbld', 07:04:32 INFO - 'MAIL': '/var/mail/cltbld', 07:04:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:32 INFO - 'MOZ_NO_REMOTE': '1', 07:04:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:32 INFO - 'NO_EM_RESTART': '1', 07:04:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:04:32 INFO - 'PWD': '/builds/slave/test-pgo', 07:04:32 INFO - 'SHELL': '/bin/bash', 07:04:32 INFO - 'SHLVL': '1', 07:04:32 INFO - 'TERM': 'linux', 07:04:32 INFO - 'TMOUT': '86400', 07:04:32 INFO - 'USER': 'cltbld', 07:04:32 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1460037833.121550-149164480', 07:04:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:32 INFO - '_': '/tools/buildbot/bin/python'} 07:04:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:04:32 INFO - Downloading/unpacking flake8 07:04:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:04:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:04:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:34 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:04:34 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:04:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:04:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:04:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:34 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:04:34 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:04:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:04:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:04:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:34 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:04:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:04:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:04:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 07:04:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:04:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:04:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:04:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:04:34 INFO - no previously-included directories found matching 'docs/_build' 07:04:34 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:04:34 INFO - Running setup.py install for pep8 07:04:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:04:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:04:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:04:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:04:35 INFO - no previously-included directories found matching 'docs/_build' 07:04:35 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 07:04:35 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:04:35 INFO - Cleaning up... 07:04:35 INFO - Return code: 0 07:04:35 INFO - Running post-action listener: _resource_record_post_action 07:04:35 INFO - Running post-action listener: _start_resource_monitoring 07:04:35 INFO - Starting resource monitoring. 07:04:35 INFO - ##### 07:04:35 INFO - ##### Running install step. 07:04:35 INFO - ##### 07:04:35 INFO - Running pre-action listener: _resource_record_pre_action 07:04:35 INFO - Running main action method: install 07:04:35 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:04:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:04:35 INFO - Reading from file tmpfile_stdout 07:04:35 INFO - Detecting whether we're running mozinstall >=1.0... 07:04:35 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 07:04:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 07:04:35 INFO - Reading from file tmpfile_stdout 07:04:35 INFO - Output received: 07:04:35 INFO - Usage: mozinstall [options] installer 07:04:35 INFO - Options: 07:04:35 INFO - -h, --help show this help message and exit 07:04:35 INFO - -d DEST, --destination=DEST 07:04:35 INFO - Directory to install application into. [default: 07:04:35 INFO - "/builds/slave/test-pgo"] 07:04:35 INFO - --app=APP Application being installed. [default: firefox] 07:04:35 INFO - mkdir: /builds/slave/test-pgo/build/application 07:04:35 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'] 07:04:35 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 07:04:51 INFO - Reading from file tmpfile_stdout 07:04:51 INFO - Output received: 07:04:51 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 07:04:51 INFO - Running post-action listener: _resource_record_post_action 07:04:51 INFO - ##### 07:04:51 INFO - ##### Running run-tests step. 07:04:51 INFO - ##### 07:04:51 INFO - Running pre-action listener: _resource_record_pre_action 07:04:51 INFO - Running main action method: run_tests 07:04:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 07:04:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 07:04:51 INFO - Python 2.7.3 07:04:51 INFO - Return code: 0 07:04:51 INFO - grabbing minidump binary from tooltool 07:04:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:04:51 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 0x22781d0>, '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 0x227b750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x227bbe0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 07:04:51 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 07:04:51 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 07:04:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:04:51 INFO - Return code: 0 07:04:51 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 07:04:51 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 07:04:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 07:04:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 07:04:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 07:04:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 07:04:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 07:04:52 INFO - Return code: 0 07:04:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YhA9EenXQnG79snKGuSYig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 07:04:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YhA9EenXQnG79snKGuSYig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 07:04:52 INFO - Using env: {'DISPLAY': ':0', 07:04:52 INFO - 'HOME': '/home/cltbld', 07:04:52 INFO - 'LANG': 'en_US.UTF-8', 07:04:52 INFO - 'LANGUAGE': 'en_US:en', 07:04:52 INFO - 'LOGNAME': 'cltbld', 07:04:52 INFO - 'MAIL': '/var/mail/cltbld', 07:04:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:04:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 07:04:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:52 INFO - 'MOZ_NO_REMOTE': '1', 07:04:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:04:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:52 INFO - 'NO_EM_RESTART': '1', 07:04:52 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:04:52 INFO - 'PWD': '/builds/slave/test-pgo', 07:04:52 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 07:04:52 INFO - 'SHELL': '/bin/bash', 07:04:52 INFO - 'SHLVL': '1', 07:04:52 INFO - 'TERM': 'linux', 07:04:52 INFO - 'TMOUT': '86400', 07:04:52 INFO - 'USER': 'cltbld', 07:04:52 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1460037833.121550-149164480', 07:04:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:52 INFO - '_': '/tools/buildbot/bin/python'} 07:04:52 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YhA9EenXQnG79snKGuSYig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:04:53 INFO - mozversion application_buildid: 20160407043123 07:04:53 INFO - mozversion application_changeset: b6683e141c47c022598c0caac3ea8ba8c6236d42 07:04:53 INFO - mozversion application_display_name: Nightly 07:04:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:04:53 INFO - mozversion application_name: Firefox 07:04:53 INFO - mozversion application_remotingname: firefox 07:04:53 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:04:53 INFO - mozversion application_vendor: Mozilla 07:04:53 INFO - mozversion application_version: 48.0a1 07:04:53 INFO - mozversion platform_buildid: 20160407043123 07:04:53 INFO - mozversion platform_changeset: b6683e141c47c022598c0caac3ea8ba8c6236d42 07:04:53 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:04:53 INFO - mozversion platform_version: 48.0a1 07:04:53 INFO - using testdate: 1460037893 07:04:53 INFO - actual date: 1460037893 07:04:53 INFO - starting webserver on 'localhost:58270' 07:04:53 INFO - SUITE-START | Running 2 tests 07:04:53 INFO - TEST-START | dromaeo_css 07:04:53 INFO - operating with platform_type : linux_ 07:04:53 INFO - Initialising browser for dromaeo_css test... 07:04:53 INFO - TEST-INFO | started process 5222 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGJFfcf/profile http://localhost:58270/getInfo.html) 07:04:57 INFO - PROCESS | 5222 | __metrics Screen width/height:1600/1200 07:04:57 INFO - PROCESS | 5222 | colorDepth:24 07:04:57 INFO - PROCESS | 5222 | Browser inner width/height: 1024/697 07:04:57 INFO - PROCESS | 5222 | __metrics 07:04:58 ERROR - PROCESS | 5222 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:04:59 INFO - TEST-INFO | 5222: exit 0 07:04:59 INFO - Browser initialized. 07:04:59 INFO - Running cycle 1/1 for dromaeo_css test... 07:04:59 INFO - TEST-INFO | started process 5302 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGJFfcf/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:05:11 INFO - PROCESS | 5302 | RSS: Main: 152481792 07:05:11 INFO - PROCESS | 5302 | 07:06:02 INFO - PROCESS | 5302 | 1460037962882 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] 07:08:09 INFO - PROCESS | 5302 | Cycle 1(1): loaded http://localhost:58270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58270/tests/dromaeo/cssquery-ext.html) 07:08:10 INFO - PROCESS | 5302 | RSS: Main: 217272320 07:08:10 INFO - PROCESS | 5302 | 07:11:12 INFO - PROCESS | 5302 | Cycle 1(1): loaded http://localhost:58270/tests/dromaeo/cssquery-ext.html (next: http://localhost:58270/tests/dromaeo/cssquery-jquery.html) 07:11:13 INFO - PROCESS | 5302 | RSS: Main: 237498368 07:11:13 INFO - PROCESS | 5302 | 07:14:15 INFO - PROCESS | 5302 | Cycle 1(1): loaded http://localhost:58270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58270/tests/dromaeo/cssquery-mootools.html) 07:14:15 INFO - PROCESS | 5302 | RSS: Main: 237096960 07:14:15 INFO - PROCESS | 5302 | 07:17:17 INFO - PROCESS | 5302 | Cycle 1(1): loaded http://localhost:58270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58270/tests/dromaeo/cssquery-prototype.html) 07:17:18 INFO - PROCESS | 5302 | RSS: Main: 220479488 07:17:18 INFO - PROCESS | 5302 | 07:20:20 INFO - PROCESS | 5302 | Cycle 1(1): loaded http://localhost:58270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58270/tests/dromaeo/cssquery-yui.html) 07:20:21 INFO - PROCESS | 5302 | RSS: Main: 219451392 07:20:21 INFO - PROCESS | 5302 | 07:23:24 INFO - PROCESS | 5302 | Cycle 1(1): loaded http://localhost:58270/tests/dromaeo/cssquery-yui.html (next: http://localhost:58270/tests/dromaeo/cssquery-dojo.html) 07:23:24 INFO - PROCESS | 5302 | RSS: Main: 269058048 07:23:24 INFO - PROCESS | 5302 | 07:23:24 INFO - PROCESS | 5302 | __start_tp_report 07:23:24 INFO - PROCESS | 5302 | _x_x_mozilla_page_load 07:23:24 INFO - PROCESS | 5302 | _x_x_mozilla_page_load_details 07:23:24 INFO - PROCESS | 5302 | |i|pagename|runs| 07:23:24 INFO - PROCESS | 5302 | |0;dojo.html;3045.695430456953;3067.309855282562;3083.7841351105426;3091.8917837875665;3124.906252812416;5129.717865517395;5132.538071573557;5155.871103222416;5196.792128314863;5201.193814958678;5219.765110570024;5244.5542128919;5276.445973172819;5285.497877701622;5290.629655924087;4763.976180119103;4781.995780886018;4795.208790549573;4824.927626085611;4874.195757699975;4727.054589082198;4839;4878.756062196893;4886.609071274307;4912.828051018215;4628.051249493862;4669.6731228814;4705.623550115983;4779.259214821691;4788.0663270662235;4751.833685821014;4755;4756.548127927841;4762.761861906891;4767.69010014348;4728.05438912219;4729.503402142795;4729.69256998294;4734.928976065362;4735.526447355272;5064.468230835783;5149.485051494858;5223.555997740196;5240.895182096375;5253.317068781034;5510.421405752419;5510.448955104457;5524.806631767869;5525.972370138124;5526.281583394173;5514.0901751211;5565.749541270652;5566.610337276392;5573.749181286852;5574.080276754331;5193.480651934814;5269.973650131763;5340.54605358545;5351.277577527062;5354.785808567653;5674.177244299553;5689.288838895138;5694.288213973254;5711.857203569944;5738.139279108083;5472.863178420572;5474.808381706621;5476.12382018883;5479.643823151482;5483.7806487740845;5416.377116631559;5478.04134276508;5547.750351234205;5611.663300202001;5618.634788738719;5563.833085007456;5570.192322113271;5584.6090773646265;5593.188987596775;5595.328560572676;5558.694271815089;5585.413531579125;5596.104623260258;5596.86007849807;5597.104463285936;4190.51809041964;4242.936355954663;4262.573742625713;4287.399764033038;4297.226499230169;3775.0373654717873;3783.375743002374;3791.1280405506886;3822.6750726188584;3823.2544653792243;5163.948360516422;5258.5267325940085;5264.368275806928;5266.947330526646;5305.336832895888;5587.720613969285;5605.915911261334;5609.27079479665;5649.915251271234;5661.264035675418;5188.533032027136;5234.979179060123;5236.557210359474;5237;5240.528352448222;4521.344405061248;4613.861584152481;4637.095766325601;4640.814367425332;4674.135284972291;5618.85952851182;5619.7471113799975;5644.74598643062;5648.181013753065;5695.943040569541;5479;5483;5492.4507549246355;5497.092979658311;5510.063289240758;5593.272874526286;5628.437156284339;5677.574181936288;5715.971420142872;5761.222234998221;5519.116941289374;5521.723913804374;5527.5577953762795;5528.19841123043;5530.004599172187;5594.440555944373;5607.495325420732;5613;5619.606627536196;5624.409437009219;5344.599155063308;5438.320209973754;5488.533474654699;5513.862153446196;5533.861653458695;5436.53789427903;5438.755256013568;5440.836774896759;5457;5460.7542660579575;5338.599605029716;5389.730513474389;5395.838124856261;5403.486668766461;5448;5308.6283960123965;5378.757955891916;5470.097433923358;5506.284183056177;5537.473939975857;5283.682979021271;5338.572914166935;5353.732313384237;5353.78584856617;5385.192221166856 07:23:24 INFO - PROCESS | 5302 | |1;ext.html;566.3025449263413;575.6488541989386;578.7569220927207;594.2215697436357;597.1669521018179;30674;38711;39586;39634.40548391776;39749;41225.58774412255;41717.37423938636;41827;41842;41862.37206441898;8523;8722.345824063188;8723.95638021809;8730.650773969033;8735.519546424945;8574.69988550401;8702.608382622766;8704.129587041309;8705.216530512253;8710.47737135774;8709.085546017672;8967.41711788735;8982.640694372218;8983.910160898373;8993.505357205351;8878.733637990837;8925.285977121815;8928.553572321423;8941.687040953568;8944.060873608276;8848.867266991001;8971.237444817198;8980.416272942302;8982.820343593157;8989.37074404792;42673.1465370694;43037;43069.56930430687;43149.68503149691;43214.78392608017;3415.4535274355985;3622;3762.6801721853676;3959.221316583142;4049.7570145791346;32450.83774581112;32762.508562371582;32869;33129.337413251844;33136.50295245573;4187.644050255732;4208.179405016023;4264;4281.036766727492;4292.763897985609;292529;292871;293539;293731;293842;60538.69730651407;60709.392906070374;60911.69544152251;60928;60996;56606.716966415726;58133.418665813646;58255.41744582585;69229.65385173041;71161.64419177872;16052.678946421007;16191.433299834449;16205.351785928431;16216.75674864878;16227.432039878784;12273.631791046282;12317;12324.753504929851;12333.198342107735;12333.50665973369;17877.553061173316;19285.73191499859;20058.197672092952;20886.477838054172;20890.477738056365;7200.495965282485;7231.349178573953;7307.3058059484265;7426.809091318074;7561.584112873735;1036.761544844675;1112.659245609039;1154.3535620052796;1154.9942250288696;1155.416514660108;32914.50628240578;32938;32956.83521582377;33020.339593208;33534.66465335364;1132.9263597866113;1140.1448913315014;1172.2263306217856;1177.8056620657667;1232.1929136415663;16405.507834764976;17341.219645116;17998.280068797103;18199.63600727978;18280.26878924855;577354;585071;586706;586964;587149;61324.69337653372;62672.05991910125;62687;62718.37281627217;62762;1400.859914008591;1421.9360128794228;1425.964350891236;1430.6709456824988;1434.9928250358682;32300.515492267165;34740;34787.13032174216;34975.13828703768;35301;51572;51875;52239.73880130575;52288.477115229885;52321.21518177154;363581;369234;369353;370162;370748;31780.36439271248;37712.6800561979;38023.42964855474;38391.6160838388;38392.6160738389;45604.54395456003;46033.079338413714;46055.53944460512;46058;46164.7691761539;38218.617813821504;38403;38723.031924200994;39021;40612.79693601513;39883.40174897437;40633;41545.584544154175;41914.58085419107;42052;41677.37483937804;42421.363679544214;42618;42703;42740.230068941535;34410.31179376348;35994;36558.4516232262;36586.26827463489;36644.81677591595;28294.448393976734;28357.74788241156;28588.713507891778;28614.42771144607;28691.232401581932 07:23:24 INFO - PROCESS | 5302 | |2;jquery.html;368.0669502810375;373.34291646701803;373.7757345592645;375.61124236415316;378.07749092214993;17327.13364331783;18547.16537755801;19764.505887352825;19769.11039003245;19786.406407807754;17856.196471158797;18238.361657341997;18597.814021859776;18660.160292786823;18670.813291867078;5471.425500322469;5516.668999860001;5629.155626656014;5644.153376993463;5645.745941432625;4034.8184331705143;5495.917561236584;5836.6206196597295;6078.361772013941;6120.785772497963;6053.515718742512;6065.0902364645435;6088.695565221743;6090.756369745205;6091.42131497507;5799.565032622549;6077.969610151965;6081.54388420868;6083;6084.391560843925;3727.0682329417646;5241.344831896013;5384.461553844623;5411.756470958777;5413.810516631899;20247;20798.48003799902;20862.53962222645;20954.790452095436;20978.685319720218;2235.1506427557424;2298.804601608865;2330.2892617751577;2479.330580743207;2507.849529028246;6924.6537673116645;11977.101717371144;12915.87084129156;13245.86754132456;13329.266890321029;1923.778765441978;1928.9131989060386;1937.5931054478576;1987.5130593004806;2026.9087891044937;67704;67790.3220967789;68139.65930170317;68531.31468685299;68593;10099.343542669703;10106.191504679608;10191.7452063699;10239.232057595711;10502.842457363146;13909.721805563831;14012.369443375073;14028.368723407471;14047.08693934891;14051.578452646438;7761.72833950809;7862.174471680506;7934.285914267628;7997.200279972072;8036.799080023046;7551.584662843597;7574.697012119454;7630.8855367169535;7631.771046868603;7741.1871753465075;6141.385861413913;6316.589421687576;6351.841203969938;6392.808215753535;6400.263969643551;1675.3298680527887;1775.2810111904698;1825.1056982078685;1850.029718349953;1859.1726681626546;987.3434166279344;1060.411471633251;1095.5159127153227;1191.541256616209;1215.2423262925547;17950.820491794915;18646.81353186478;18844.15201315944;19330.03349832503;19416.514587135152;1032.9721926682998;1041.7135287795916;1053.2837670384213;1081.313366012572;1128.5711429656678;10820.513076911559;11351.37567433799;11412.486438110305;11430.771384572428;11445;466850;471020;478674;481392;482197;69850.65074674696;74400.62799685966;74554.25445745581;74790.62604686942;76567.61716191383;1034.7930413917247;1042.1923009667416;1053.9947300263602;1074.3392813419691;1083.3608171178885;16918.746218806482;16983.065931373894;17081.82918170852;17140.314387424365;17214.39749608758;36621.450678239315;36785.26429471449;36913.630863692095;37439.43840842335;37563.24873502569;48047;48436.757816210695;48890.51109488859;49009.50990490049;49122.26316605325;8186.672533098847;8351.523203947876;8502.574871256536;8528.829423411373;8556.058833528432;9260.212881904845;11932.701682458008;12365.381730913597;12636.42044744407;13009.414576343897;9414.246860251027;11181.217314787888;11347.148963827582;11383.658490245305;11439.542418303508;7762.223777622193;7961.800954976172;11015.228933974866;11448.313101213955;11464.140189485655;11488.19582629208;11848.466818992994;11901.880981190423;11935.582254621047;12036.63890083299;8325.95837020811;8347.666093356198;8359.707410240855;8533.701320453754;8622.65509379643;11045.171612129283;11561.942190288995;11596.246243994114;11689.123315751183;11789.056875450115 07:23:24 INFO - PROCESS | 5302 | |3;mootools.html;1374.257900733604;1499.3178103962698;1505.4806091898295;1663.168415792104;1800.756897818794;7955.522668639878;8119.188081191885;8120.350371970243;8125.674973001072;8131.918680813204;7889.80275493113;7914.881276780839;7970.043594768621;7971;7975.561344126085;2057.6913462980524;2297.27635794725;2333.1717240379676;2356.4697942962866;2356.6229403295474;2361.327021798788;2372.264597974625;2374.25211058516;2375.394274460019;2378.120095564635;2314.3982564533258;2317.432229103872;2373.845700029501;2378.4053986503372;2379.6073647848084;2276.4195130241847;2301.827362947786;2317.617593097137;2332.416895776056;2334.1130370459286;2298.276043046435;2310.2145270608075;2332.918347857817;2338.0530884991604;2376.821738369629;8264.338852891755;8329.125441828643;8337;8339.24946754795;8353.37349698769;5124.103281925685;5249.527542521153;5276.261323414687;5284.709340986245;5286.444923283077;3363.899083027513;3386.4750963600436;3428.777129486575;3458.9308213835584;3460.1176699941607;1087.130295763394;1092.3882625729616;1094.217634391406;1127.6729748372961;1154.4285578638544;11645.708857278467;11663.008644265248;11705.063594912386;11732.413379331;11732.413379331085;4600;4621.329907163443;4639.744814035261;4673.7429441381055;4692;9844;9882.950585247028;9898.257630677728;9898.30711850178;9900.60397584103;5211.166213405837;5238.188080847474;5256.894862102737;5265.21021846726;5269.314989051475;4049.959500405017;4609.262517997105;4700.435947686299;4708.976455117771;4709.952900470951;3797.9430308545393;3853.614638536124;3879.243547508209;3904.882853514399;3918.7060970427333;1246.4141853328922;1259.924404535731;1271.2245530226555;1272.332025686522;1274.5411651805343;1411.0968979852903;1425.5081996711117;1445.3206992713408;1446.9638259043609;1455.8980871338904;7955.4828936118965;8091.705327147628;8096;8103.473274237156;8111.594420278962;495.71744105860034;506.71623890620634;511.15148852904;515.7421289355323;516.6848222584221;5957.731902064417;5978.282606087298;5980.461758441674;6021.307549631761;6031.095335699592;9605.615775368908;9615.51922403877;9644.083812037845;9738.610455581698;9780.804383912282;9436.480993545421;9585.952070239744;9603.327767056238;9631.08504692053;9636.036396360449;7847.568383738835;7966.6415011324625;7997.960010200029;8057.798555036171;8065.838683226302;7776.961115194388;7842.333401660922;7867.488613240121;7895.131535531202;7934;8946.68686595966;9211.631534738535;9290.814183716422;9293.070692930653;9299.163075323253;9239.38823505923;9341.11259430353;9395.389299695498;9445.763855903657;9501.717268168984;6435.678216089271;7153.856922861618;7260.4554658401885;7432.591207483641;7554.320111190019;7942.761717148494;7948.284654381134;7993.040835099825;8005.159458257032;8017.198280171936;6966.164060312795;7044.682989265598;7060.293970603104;7183.964080179775;7415.592142432218;6898.827529311808;6949.444044476329;7007.124109486314;7087.397571206505;7219.711211551479;7049.541779784297;7538.509996850187;7544.132424771222;7546.9622651888585;7556.093268807778;7017.228104908354;7031.367176954099;7032.578045317297;7057.752978645723;7064.788056358318;6911.101556797584;6932.306769323229;6934.237233904166;6937.445004399737;6989.091418115612 07:23:24 INFO - PROCESS | 5302 | |4;prototype.html;345.0700362523;347.2308835928419;349.8810404462482;350.1264345458082;354.65066909094537;5974.432428919251;6000.7299671514775;6019.608725432855;6038;6040.546958978072;5927.110933359998;5931.347551769302;5935.910961335572;5937.495312898398;5974.611650242742;4378.211921854065;4474.8881277967985;4580.679352445331;4625.190591646457;4632.143053535106;4626.375439315683;4630.564524997245;4632.606228470584;4641.744704041276;4644.396228490308;4588.334691469735;4593.242115051013;4602.12559613674;4602.286645569925;4614.007988282518;4358.6077253047215;4490.685652004361;4562.498125206224;4574.656900732459;4617.353570500132;4069.4506241657296;4069.552349241581;4078.9592104078874;4079.653229475498;4087.795610219477;5712.57155713319;5730.025895597759;5730.484256416942;5736.4550367715;5738.942610573882;5333.626646134772;5334.679919204821;5338.145896656516;5339.5728341732565;5344.973275133639;6291.7168727406915;6295.338989406138;6300.968495157541;6302.369763023661;6302.96848515759;4399.824007039714;4499.235130027903;4502.797374118172;4509.729416235004;4511.593956543927;6472.644004579746;6521.478281737497;6524.412802847766;6528.445082168021;6539.901901471481;4604.30935359692;4605.102005109038;4605.263157894721;4607.723536587815;4612.3542704021465;4665.4168228971375;4678.321643361762;4683.391159149357;4685.367475390779;4689.906201875943;5323.680579165262;5324.281222035053;5324.653897496651;5331.30693009914;5338.225957236179;6067.908981365194;6282.403171698681;6297.181366422427;6312.684365781693;6321.399467050623;1574.8976316539618;1598.4964736108088;1600.4798440506881;1604.0536083710667;1610.1385758619083;982.7199248214224;1040.6513817870946;1050.4275170032352;1051.9211059170593;1072.0565902006185;5967.791127310524;6036;6039.426254505903;6070.605410648293;6124.908126378108;6418.807435776934;6448.774292899726;6454.19322584677;6458.54790164684;6460.903086453707;6034.547408944259;6035.66803825785;6046.546509011841;6092.908606370908;6112.419320164578;3446.3107378523896;3484.094135524731;3485.3203625292826;3486.7210623150086;3488;6603.339666033455;6643.900341494881;6647.800565983028;6811.557248778813;6822.079019332426;6710.295418980937;6731.899021514681;6739.966300168468;6748.055272261888;6760.628165450948;6778.627175505395;6789.1852977643985;6795.490338224653;6796.830079248059;6808.387245147861;6575.309592492719;6580.5722628029025;6594;6594.670266486561;6602.141721576357;6330.683465826598;6483.740650374121;6494.350564943468;6504.252011018793;6512.120863683342;6758.5606935550995;6777.254502004874;6784.118064651761;6789.388954994074;6791.694373753094;4502.4371953505815;4546.659000575036;4554.089182163647;4557.977210113928;4561.064981678815;6556.311587283267;6562.442192413699;6573.638449885302;6575;6582.506312026521;6415.037744338387;6427.389398007182;6431.742730290736;6438.903416448663;6442.194725659293;6225.439710426083;6360.4911607072245;6389.211020914151;6395.456386207225;6396.616203027833;6250.156228909221;6258.249010118815;6266.404691554295;6280.717367718372;6282.811515654537;6417.2299324081405;6426.518011149089;6428.774992875227;6436.935630643821;6438;5967.701614919323;6099.969500152471;6272.153259309935;6283.057541368831;6296.087067375296 07:23:24 INFO - PROCESS | 5302 | |5;yui.html;825.0264687668549;841.3605659698628;843.4475418600811;865.9956700216497;874.4884242718009;14107.224102674349;14337.354819033155;15959.601009974756;16200.270987805548;16227.594310142253;15344;15429.228538573054;15458.07251564907;15495.690086198269;15536.68926621467;702.332783855337;830.1366578758084;835.1147783349653;842.5071333270045;847.6482259862149;837.5142417397925;840.4285086141422;841.3521588376946;841.9873701894477;842.1031601344548;879.9208071273584;885.3404213860683;885.3846576629245;886.1448702002566;886.246690313235;725.0574253470494;861.6294993152942;869.2524428991063;882.0738224863867;883.1477624092781;635.6440393379676;638.113022898172;638.1640051532507;638.5976834594222;640.0527219714802;14173.574792756233;14268.92865535676;14290.285485725672;14293.499727509487;14435.494757683431;13263.602091937257;13479.393427295796;13539;13717.314134293345;13802.65493362664;10696.946515267375;11169.553217871357;11265.211435199539;11417.657470275904;11702.941485292604;3739.2708421857747;3800.068983099131;3822.0827001519433;3826.789526576037;3852.537695476533;54259;54830.9999999996;55128.448715513136;55410.72294638542;56142.43857561413;10591.364518128938;10671.092957098579;10700.625478108228;10728.356298622108;10858.2399232053;19305.324313649235;19390.321338753078;19992.60014799696;20024.199032038556;20076.498087547636;8380.161983801692;8460.8730869037;8509;8553;8613.3109351253;4924.532169443897;4953.950460495421;4975.0796102721115;4978.502149785065;5060.7216603086445;3290.1445624137896;3298.7855789373616;3335.69978701918;3336.9822204227944;3345.882894098695;515.2425933877195;587.3568442555395;626.0734113511937;632.5761739634456;635.2218532297898;628.5914155798768;701.5965819653719;717.218232126984;723.8841785314324;732.7508647060025;9101.635934562544;9300.20948219409;9396.765080872896;9408.858867116998;9578.90421095794;725.5066554742825;739.3087463221905;749.5615065186927;753.0887625972525;754.7811134770855;4243.533211346749;4382.912341753147;4410;4507.661925355612;4580.564846339593;57777.71111144417;58889;58916;61945.69027154835;62021.68989155025;48909.510904891205;49837.50162498401;49884.25173622399;50279;50658;44198.11603767971;44336.77831610821;44371.77814110909;44413;45030.77484612556;9339.766505837408;9432.481213533321;9437.669681561112;9525.047495250697;9954.452505111998;34835.651643484256;35682.28635427225;36338.4549231767;36463;36790.63209367872;42625.14749705051;42831.35752963646;43017.784911076495;44882.326765099206;45115;11689.009643806074;11783.351915644722;11973.521059157536;12005.159638825198;12297.631071067883;11802.586909458129;11849.289042657469;12746.872531274568;13421.463141474622;13489.797653035408;12440.066994975232;13143.671408214872;13180.472781088649;13241.602751917459;13259.270740109387;12096.637100886988;12370.75258494843;12977.870221297666;12987.740245194855;13006.934965325112;12647.114701970773;12721.236725796482;13319.866801331862;13401.932990335376;13415.664608384868;9537.284703647392;9579.9042009579;9854.310198286052;9975.3017288792;10174.287799853939;8374.120717324593;8385.454945428528;8397.832043358976;8453.36599755033;8554.358423118416 07:23:24 INFO - PROCESS | 5302 | __end_tp_report 07:23:24 INFO - PROCESS | 5302 | __start_cc_report 07:23:24 INFO - PROCESS | 5302 | _x_x_mozilla_cycle_collect,907 07:23:24 INFO - PROCESS | 5302 | __end_cc_report 07:23:24 INFO - PROCESS | 5302 | __startTimestamp1460039004419__endTimestamp 07:23:24 INFO - PROCESS | 5302 | 07:23:24 INFO - PROCESS | 5302 | ------- Summary: start ------- 07:23:24 INFO - PROCESS | 5302 | Number of tests: 6 07:23:24 INFO - PROCESS | 5302 | 07:23:24 INFO - PROCESS | 5302 | [#0] dojo.html Cycles:165 Average:5170.71 Median:5378.76 stddev:574.51 (10.7%) stddev-sans-first:551.56 07:23:24 INFO - PROCESS | 5302 | Values: 3045.7 3067.3 3083.8 3091.9 3124.9 5129.7 5132.5 5155.9 5196.8 5201.2 5219.8 5244.6 5276.4 5285.5 5290.6 4764.0 4782.0 4795.2 4824.9 4874.2 4727.1 4839.0 4878.8 4886.6 4912.8 4628.1 4669.7 4705.6 4779.3 4788.1 4751.8 4755.0 4756.5 4762.8 4767.7 4728.1 4729.5 4729.7 4734.9 4735.5 5064.5 5149.5 5223.6 5240.9 5253.3 5510.4 5510.4 5524.8 5526.0 5526.3 5514.1 5565.7 5566.6 5573.7 5574.1 5193.5 5270.0 5340.5 5351.3 5354.8 5674.2 5689.3 5694.3 5711.9 5738.1 5472.9 5474.8 5476.1 5479.6 5483.8 5416.4 5478.0 5547.8 5611.7 5618.6 5563.8 5570.2 5584.6 5593.2 5595.3 5558.7 5585.4 5596.1 5596.9 5597.1 4190.5 4242.9 4262.6 4287.4 4297.2 3775.0 3783.4 3791.1 3822.7 3823.3 5163.9 5258.5 5264.4 5266.9 5305.3 5587.7 5605.9 5609.3 5649.9 5661.3 5188.5 5235.0 5236.6 5237.0 5240.5 4521.3 4613.9 4637.1 4640.8 4674.1 5618.9 5619.7 5644.7 5648.2 5695.9 5479.0 5483.0 5492.5 5497.1 5510.1 5593.3 5628.4 5677.6 5716.0 5761.2 5519.1 5521.7 5527.6 5528.2 5530.0 5594.4 5607.5 5613.0 5619.6 5624.4 5344.6 5438.3 5488.5 5513.9 5533.9 5436.5 5438.8 5440.8 5457.0 5460.8 5338.6 5389.7 5395.8 5403.5 5448.0 5308.6 5378.8 5470.1 5506.3 5537.5 5283.7 5338.6 5353.7 5353.8 5385.2 07:23:24 INFO - PROCESS | 5302 | 07:23:24 INFO - PROCESS | 5302 | [#1] ext.html Cycles:180 Average:58530.58 Median:40622.90 stddev:115221.12 (283.6%) stddev-sans-first:115462.15 07:23:24 INFO - PROCESS | 5302 | Values: 566.3 575.6 578.8 594.2 597.2 30674.0 38711.0 39586.0 39634.4 39749.0 41225.6 41717.4 41827.0 41842.0 41862.4 8523.0 8722.3 8724.0 8730.7 8735.5 8574.7 8702.6 8704.1 8705.2 8710.5 8709.1 8967.4 8982.6 8983.9 8993.5 8878.7 8925.3 8928.6 8941.7 8944.1 8848.9 8971.2 8980.4 8982.8 8989.4 42673.1 43037.0 43069.6 43149.7 43214.8 3415.5 3622.0 3762.7 3959.2 4049.8 32450.8 32762.5 32869.0 33129.3 33136.5 4187.6 4208.2 4264.0 4281.0 4292.8 292529.0 292871.0 293539.0 293731.0 293842.0 60538.7 60709.4 60911.7 60928.0 60996.0 56606.7 58133.4 58255.4 69229.7 71161.6 16052.7 16191.4 16205.4 16216.8 16227.4 12273.6 12317.0 12324.8 12333.2 12333.5 17877.6 19285.7 20058.2 20886.5 20890.5 7200.5 7231.3 7307.3 7426.8 7561.6 1036.8 1112.7 1154.4 1155.0 1155.4 32914.5 32938.0 32956.8 33020.3 33534.7 1132.9 1140.1 1172.2 1177.8 1232.2 16405.5 17341.2 17998.3 18199.6 18280.3 577354.0 585071.0 586706.0 586964.0 587149.0 61324.7 62672.1 62687.0 62718.4 62762.0 1400.9 1421.9 1426.0 1430.7 1435.0 32300.5 34740.0 34787.1 34975.1 35301.0 51572.0 51875.0 52239.7 52288.5 52321.2 363581.0 369234.0 369353.0 370162.0 370748.0 31780.4 37712.7 38023.4 38391.6 38392.6 45604.5 46033.1 46055.5 46058.0 46164.8 38218.6 38403.0 38723.0 39021.0 40612.8 39883.4 40633.0 41545.6 41914.6 42052.0 41677.4 42421.4 42618.0 42703.0 42740.2 34410.3 35994.0 36558.5 36586.3 36644.8 28294.4 28357.7 28588.7 28614.4 28691.2 07:23:24 INFO - PROCESS | 5302 | 07:23:24 INFO - PROCESS | 5302 | [#2] jquery.html Cycles:180 Average:27169.56 Median:2314.55 stddev:77928.62 (3366.9%) stddev-sans-first:78121.25 07:23:24 INFO - PROCESS | 5302 | Values: 368.1 373.3 373.8 375.6 378.1 17327.1 18547.2 19764.5 19769.1 19786.4 17856.2 18238.4 18597.8 18660.2 18670.8 5471.4 5516.7 5629.2 5644.2 5645.7 4034.8 5495.9 5836.6 6078.4 6120.8 6053.5 6065.1 6088.7 6090.8 6091.4 5799.6 6078.0 6081.5 6083.0 6084.4 3727.1 5241.3 5384.5 5411.8 5413.8 20247.0 20798.5 20862.5 20954.8 20978.7 2235.2 2298.8 2330.3 2479.3 2507.8 6924.7 11977.1 12915.9 13245.9 13329.3 1923.8 1928.9 1937.6 1987.5 2026.9 67704.0 67790.3 68139.7 68531.3 68593.0 10099.3 10106.2 10191.7 10239.2 10502.8 13909.7 14012.4 14028.4 14047.1 14051.6 7761.7 7862.2 7934.3 7997.2 8036.8 7551.6 7574.7 7630.9 7631.8 7741.2 6141.4 6316.6 6351.8 6392.8 6400.3 1675.3 1775.3 1825.1 1850.0 1859.2 987.3 1060.4 1095.5 1191.5 1215.2 17950.8 18646.8 18844.2 19330.0 19416.5 1033.0 1041.7 1053.3 1081.3 1128.6 10820.5 11351.4 11412.5 11430.8 11445.0 466850.0 471020.0 478674.0 481392.0 482197.0 69850.7 74400.6 74554.3 74790.6 76567.6 1034.8 1042.2 1054.0 1074.3 1083.4 16918.7 16983.1 17081.8 17140.3 17214.4 36621.5 36785.3 36913.6 37439.4 37563.2 48047.0 48436.8 48890.5 49009.5 49122.3 8186.7 8351.5 8502.6 8528.8 8556.1 9260.2 11932.7 12365.4 12636.4 13009.4 9414.2 11181.2 11347.1 11383.7 11439.5 7762.2 7961.8 11015.2 11448.3 11464.1 11488.2 11848.5 11901.9 11935.6 12036.6 8326.0 8347.7 8359.7 8533.7 8622.7 11045.2 11561.9 11596.2 11689.1 11789.1 07:23:24 INFO - PROCESS | 5302 | 07:23:24 INFO - PROCESS | 5302 | [#3] mootools.html Cycles:180 Average:5804.77 Median:6667.25 stddev:3045.94 (45.7%) stddev-sans-first:3036.27 07:23:24 INFO - PROCESS | 5302 | Values: 1374.3 1499.3 1505.5 1663.2 1800.8 7955.5 8119.2 8120.4 8125.7 8131.9 7889.8 7914.9 7970.0 7971.0 7975.6 2057.7 2297.3 2333.2 2356.5 2356.6 2361.3 2372.3 2374.3 2375.4 2378.1 2314.4 2317.4 2373.8 2378.4 2379.6 2276.4 2301.8 2317.6 2332.4 2334.1 2298.3 2310.2 2332.9 2338.1 2376.8 8264.3 8329.1 8337.0 8339.2 8353.4 5124.1 5249.5 5276.3 5284.7 5286.4 3363.9 3386.5 3428.8 3458.9 3460.1 1087.1 1092.4 1094.2 1127.7 1154.4 11645.7 11663.0 11705.1 11732.4 11732.4 4600.0 4621.3 4639.7 4673.7 4692.0 9844.0 9883.0 9898.3 9898.3 9900.6 5211.2 5238.2 5256.9 5265.2 5269.3 4050.0 4609.3 4700.4 4709.0 4710.0 3797.9 3853.6 3879.2 3904.9 3918.7 1246.4 1259.9 1271.2 1272.3 1274.5 1411.1 1425.5 1445.3 1447.0 1455.9 7955.5 8091.7 8096.0 8103.5 8111.6 495.7 506.7 511.2 515.7 516.7 5957.7 5978.3 5980.5 6021.3 6031.1 9605.6 9615.5 9644.1 9738.6 9780.8 9436.5 9586.0 9603.3 9631.1 9636.0 7847.6 7966.6 7998.0 8057.8 8065.8 7777.0 7842.3 7867.5 7895.1 7934.0 8946.7 9211.6 9290.8 9293.1 9299.2 9239.4 9341.1 9395.4 9445.8 9501.7 6435.7 7153.9 7260.5 7432.6 7554.3 7942.8 7948.3 7993.0 8005.2 8017.2 6966.2 7044.7 7060.3 7184.0 7415.6 6898.8 6949.4 7007.1 7087.4 7219.7 7049.5 7538.5 7544.1 7547.0 7556.1 7017.2 7031.4 7032.6 7057.8 7064.8 6911.1 6932.3 6934.2 6937.4 6989.1 07:23:24 INFO - PROCESS | 5302 | 07:23:24 INFO - PROCESS | 5302 | [#4] prototype.html Cycles:180 Average:5317.92 Median:6035.83 stddev:1593.52 (26.4%) stddev-sans-first:1553.67 07:23:24 INFO - PROCESS | 5302 | Values: 345.1 347.2 349.9 350.1 354.7 5974.4 6000.7 6019.6 6038.0 6040.5 5927.1 5931.3 5935.9 5937.5 5974.6 4378.2 4474.9 4580.7 4625.2 4632.1 4626.4 4630.6 4632.6 4641.7 4644.4 4588.3 4593.2 4602.1 4602.3 4614.0 4358.6 4490.7 4562.5 4574.7 4617.4 4069.5 4069.6 4079.0 4079.7 4087.8 5712.6 5730.0 5730.5 5736.5 5738.9 5333.6 5334.7 5338.1 5339.6 5345.0 6291.7 6295.3 6301.0 6302.4 6303.0 4399.8 4499.2 4502.8 4509.7 4511.6 6472.6 6521.5 6524.4 6528.4 6539.9 4604.3 4605.1 4605.3 4607.7 4612.4 4665.4 4678.3 4683.4 4685.4 4689.9 5323.7 5324.3 5324.7 5331.3 5338.2 6067.9 6282.4 6297.2 6312.7 6321.4 1574.9 1598.5 1600.5 1604.1 1610.1 982.7 1040.7 1050.4 1051.9 1072.1 5967.8 6036.0 6039.4 6070.6 6124.9 6418.8 6448.8 6454.2 6458.5 6460.9 6034.5 6035.7 6046.5 6092.9 6112.4 3446.3 3484.1 3485.3 3486.7 3488.0 6603.3 6643.9 6647.8 6811.6 6822.1 6710.3 6731.9 6740.0 6748.1 6760.6 6778.6 6789.2 6795.5 6796.8 6808.4 6575.3 6580.6 6594.0 6594.7 6602.1 6330.7 6483.7 6494.4 6504.3 6512.1 6758.6 6777.3 6784.1 6789.4 6791.7 4502.4 4546.7 4554.1 4558.0 4561.1 6556.3 6562.4 6573.6 6575.0 6582.5 6415.0 6427.4 6431.7 6438.9 6442.2 6225.4 6360.5 6389.2 6395.5 6396.6 6250.2 6258.2 6266.4 6280.7 6282.8 6417.2 6426.5 6428.8 6436.9 6438.0 5967.7 6100.0 6272.2 6283.1 6296.1 07:23:24 INFO - PROCESS | 5302 | 07:23:24 INFO - PROCESS | 5302 | [#5] yui.html Cycles:180 Average:14503.08 Median:26745.04 stddev:16321.74 (61.0%) stddev-sans-first:16335.20 07:23:24 INFO - PROCESS | 5302 | Values: 825.0 841.4 843.4 866.0 874.5 14107.2 14337.4 15959.6 16200.3 16227.6 15344.0 15429.2 15458.1 15495.7 15536.7 702.3 830.1 835.1 842.5 847.6 837.5 840.4 841.4 842.0 842.1 879.9 885.3 885.4 886.1 886.2 725.1 861.6 869.3 882.1 883.1 635.6 638.1 638.2 638.6 640.1 14173.6 14268.9 14290.3 14293.5 14435.5 13263.6 13479.4 13539.0 13717.3 13802.7 10696.9 11169.6 11265.2 11417.7 11702.9 3739.3 3800.1 3822.1 3826.8 3852.5 54259.0 54831.0 55128.4 55410.7 56142.4 10591.4 10671.1 10700.6 10728.4 10858.2 19305.3 19390.3 19992.6 20024.2 20076.5 8380.2 8460.9 8509.0 8553.0 8613.3 4924.5 4954.0 4975.1 4978.5 5060.7 3290.1 3298.8 3335.7 3337.0 3345.9 515.2 587.4 626.1 632.6 635.2 628.6 701.6 717.2 723.9 732.8 9101.6 9300.2 9396.8 9408.9 9578.9 725.5 739.3 749.6 753.1 754.8 4243.5 4382.9 4410.0 4507.7 4580.6 57777.7 58889.0 58916.0 61945.7 62021.7 48909.5 49837.5 49884.3 50279.0 50658.0 44198.1 44336.8 44371.8 44413.0 45030.8 9339.8 9432.5 9437.7 9525.0 9954.5 34835.7 35682.3 36338.5 36463.0 36790.6 42625.1 42831.4 43017.8 44882.3 45115.0 11689.0 11783.4 11973.5 12005.2 12297.6 11802.6 11849.3 12746.9 13421.5 13489.8 12440.1 13143.7 13180.5 13241.6 13259.3 12096.6 12370.8 12977.9 12987.7 13006.9 12647.1 12721.2 13319.9 13401.9 13415.7 9537.3 9579.9 9854.3 9975.3 10174.3 8374.1 8385.5 8397.8 8453.4 8554.4 07:23:24 INFO - PROCESS | 5302 | -------- Summary: end -------- 07:23:24 INFO - PROCESS | 5302 | 07:23:25 INFO - TEST-INFO | 5302: exit 0 07:23:25 INFO - TEST-OK | dromaeo_css | took 1111950ms 07:23:25 INFO - TEST-START | kraken 07:23:25 INFO - operating with platform_type : linux_ 07:23:25 INFO - Initialising browser for kraken test... 07:23:25 INFO - TEST-INFO | started process 5484 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJZyzec/profile http://localhost:58270/getInfo.html) 07:23:29 INFO - PROCESS | 5484 | __metrics Screen width/height:1600/1200 07:23:29 INFO - PROCESS | 5484 | colorDepth:24 07:23:29 INFO - PROCESS | 5484 | Browser inner width/height: 1024/697 07:23:29 INFO - PROCESS | 5484 | __metrics 07:23:30 ERROR - PROCESS | 5484 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:23:31 INFO - TEST-INFO | 5484: exit 0 07:23:31 INFO - Browser initialized. 07:23:31 INFO - Running cycle 1/1 for kraken test... 07:23:31 INFO - TEST-INFO | started process 5564 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJZyzec/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:23:42 INFO - PROCESS | 5564 | RSS: Main: 152702976 07:23:42 INFO - PROCESS | 5564 | 07:23:45 INFO - PROCESS | 5564 | Cycle 1(1): loaded http://localhost:58270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58270/tests/kraken/driver.html?testName=audio-beat-detection) 07:23:45 INFO - PROCESS | 5564 | RSS: Main: 193777664 07:23:45 INFO - PROCESS | 5564 | 07:23:48 INFO - PROCESS | 5564 | Cycle 1(1): loaded http://localhost:58270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58270/tests/kraken/driver.html?testName=audio-dft) 07:23:49 INFO - PROCESS | 5564 | RSS: Main: 183349248 07:23:49 INFO - PROCESS | 5564 | 07:23:52 INFO - PROCESS | 5564 | Cycle 1(1): loaded http://localhost:58270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58270/tests/kraken/driver.html?testName=audio-fft) 07:23:52 INFO - PROCESS | 5564 | RSS: Main: 166989824 07:23:52 INFO - PROCESS | 5564 | 07:23:54 INFO - PROCESS | 5564 | Cycle 1(1): loaded http://localhost:58270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58270/tests/kraken/driver.html?testName=audio-oscillator) 07:23:55 INFO - PROCESS | 5564 | RSS: Main: 170405888 07:23:55 INFO - PROCESS | 5564 | 07:23:57 INFO - PROCESS | 5564 | Cycle 1(1): loaded http://localhost:58270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:23:58 INFO - PROCESS | 5564 | RSS: Main: 172478464 07:23:58 INFO - PROCESS | 5564 | 07:24:01 INFO - PROCESS | 5564 | Cycle 1(1): loaded http://localhost:58270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58270/tests/kraken/driver.html?testName=imaging-darkroom) 07:24:01 INFO - PROCESS | 5564 | RSS: Main: 171810816 07:24:01 INFO - PROCESS | 5564 | 07:24:04 INFO - PROCESS | 5564 | Cycle 1(1): loaded http://localhost:58270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58270/tests/kraken/driver.html?testName=imaging-desaturate) 07:24:05 INFO - PROCESS | 5564 | RSS: Main: 172568576 07:24:05 INFO - PROCESS | 5564 | 07:24:08 INFO - PROCESS | 5564 | Cycle 1(1): loaded http://localhost:58270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58270/tests/kraken/driver.html?testName=json-parse-financial) 07:24:08 INFO - PROCESS | 5564 | RSS: Main: 173096960 07:24:08 INFO - PROCESS | 5564 | 07:24:10 INFO - PROCESS | 5564 | Cycle 1(1): loaded http://localhost:58270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:24:11 INFO - PROCESS | 5564 | RSS: Main: 181673984 07:24:11 INFO - PROCESS | 5564 | 07:24:12 INFO - PROCESS | 5564 | Cycle 1(1): loaded http://localhost:58270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58270/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:24:13 INFO - PROCESS | 5564 | RSS: Main: 180465664 07:24:13 INFO - PROCESS | 5564 | 07:24:15 INFO - PROCESS | 5564 | Cycle 1(1): loaded http://localhost:58270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:24:16 INFO - PROCESS | 5564 | RSS: Main: 190652416 07:24:16 INFO - PROCESS | 5564 | 07:24:18 INFO - PROCESS | 5564 | Cycle 1(1): loaded http://localhost:58270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:24:19 INFO - PROCESS | 5564 | RSS: Main: 197189632 07:24:19 INFO - PROCESS | 5564 | 07:24:21 INFO - PROCESS | 5564 | Cycle 1(1): loaded http://localhost:58270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:24:22 INFO - PROCESS | 5564 | RSS: Main: 196243456 07:24:22 INFO - PROCESS | 5564 | 07:24:23 INFO - PROCESS | 5564 | Cycle 1(1): loaded http://localhost:58270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58270/tests/kraken/driver.html?testName=ai-astar) 07:24:24 INFO - PROCESS | 5564 | RSS: Main: 258396160 07:24:24 INFO - PROCESS | 5564 | 07:24:24 INFO - PROCESS | 5564 | __start_tp_report 07:24:24 INFO - PROCESS | 5564 | _x_x_mozilla_page_load 07:24:24 INFO - PROCESS | 5564 | _x_x_mozilla_page_load_details 07:24:24 INFO - PROCESS | 5564 | |i|pagename|runs| 07:24:24 INFO - PROCESS | 5564 | |0;ai-astar;110;111;107;109;109;112;102;111;111;109 07:24:24 INFO - PROCESS | 5564 | |1;audio-beat-detection;149;126;152;168;127;152;160;128;173;134 07:24:24 INFO - PROCESS | 5564 | |2;audio-dft;161;160;163;161;162;162;162;163;170;161 07:24:24 INFO - PROCESS | 5564 | |3;audio-fft;76;74;100;103;73;72;73;130;97;75 07:24:24 INFO - PROCESS | 5564 | |4;audio-oscillator;93;93;138;95;93;92;136;94;92;142 07:24:24 INFO - PROCESS | 5564 | |5;imaging-gaussian-blur;117;117;116;116;117;117;116;117;117;116 07:24:24 INFO - PROCESS | 5564 | |6;imaging-darkroom;146;146;145;151;146;145;146;145;145;145 07:24:24 INFO - PROCESS | 5564 | |7;imaging-desaturate;96;95;95;95;95;95;96;95;95;95 07:24:24 INFO - PROCESS | 5564 | |8;json-parse-financial;57;57;56;56;57;56;56;65;55;55 07:24:24 INFO - PROCESS | 5564 | |9;json-stringify-tinderbox;62;62;65;62;62;63;63;62;63;62 07:24:24 INFO - PROCESS | 5564 | |10;stanford-crypto-aes;79;80;78;80;78;78;78;79;80;86 07:24:24 INFO - PROCESS | 5564 | |11;stanford-crypto-ccm;118;112;122;119;110;121;114;113;120;116 07:24:24 INFO - PROCESS | 5564 | |12;stanford-crypto-pbkdf2;143;144;143;153;142;143;146;140;140;142 07:24:24 INFO - PROCESS | 5564 | |13;stanford-crypto-sha256-iterative;63;65;64;62;65;65;64;64;63;65 07:24:24 INFO - PROCESS | 5564 | __end_tp_report 07:24:24 INFO - PROCESS | 5564 | __start_cc_report 07:24:24 INFO - PROCESS | 5564 | _x_x_mozilla_cycle_collect,1112 07:24:24 INFO - PROCESS | 5564 | __end_cc_report 07:24:24 INFO - PROCESS | 5564 | __startTimestamp1460039064036__endTimestamp 07:24:24 INFO - PROCESS | 5564 | 07:24:24 INFO - PROCESS | 5564 | ------- Summary: start ------- 07:24:24 INFO - PROCESS | 5564 | Number of tests: 14 07:24:24 INFO - PROCESS | 5564 | 07:24:24 INFO - PROCESS | 5564 | [#0] ai-astar Cycles:10 Average:109.10 Median:110.50 stddev:2.88 (2.6%) stddev-sans-first:3.04 07:24:24 INFO - PROCESS | 5564 | Values: 110.0 111.0 107.0 109.0 109.0 112.0 102.0 111.0 111.0 109.0 07:24:24 INFO - PROCESS | 5564 | 07:24:24 INFO - PROCESS | 5564 | [#1] audio-beat-detection Cycles:10 Average:146.90 Median:152.00 stddev:17.36 (11.4%) stddev-sans-first:18.39 07:24:24 INFO - PROCESS | 5564 | Values: 149.0 126.0 152.0 168.0 127.0 152.0 160.0 128.0 173.0 134.0 07:24:24 INFO - PROCESS | 5564 | 07:24:24 INFO - PROCESS | 5564 | [#2] audio-dft Cycles:10 Average:162.50 Median:162.00 stddev:2.80 (1.7%) stddev-sans-first:2.92 07:24:24 INFO - PROCESS | 5564 | Values: 161.0 160.0 163.0 161.0 162.0 162.0 162.0 163.0 170.0 161.0 07:24:24 INFO - PROCESS | 5564 | 07:24:24 INFO - PROCESS | 5564 | [#3] audio-fft Cycles:10 Average:87.30 Median:73.50 stddev:19.51 (26.5%) stddev-sans-first:20.26 07:24:24 INFO - PROCESS | 5564 | Values: 76.0 74.0 100.0 103.0 73.0 72.0 73.0 130.0 97.0 75.0 07:24:24 INFO - PROCESS | 5564 | 07:24:24 INFO - PROCESS | 5564 | [#4] audio-oscillator Cycles:10 Average:106.80 Median:93.00 stddev:22.05 (23.7%) stddev-sans-first:22.82 07:24:24 INFO - PROCESS | 5564 | Values: 93.0 93.0 138.0 95.0 93.0 92.0 136.0 94.0 92.0 142.0 07:24:24 INFO - PROCESS | 5564 | 07:24:24 INFO - PROCESS | 5564 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 07:24:24 INFO - PROCESS | 5564 | Values: 117.0 117.0 116.0 116.0 117.0 117.0 116.0 117.0 117.0 116.0 07:24:24 INFO - PROCESS | 5564 | 07:24:24 INFO - PROCESS | 5564 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:1.83 (1.3%) stddev-sans-first:1.94 07:24:24 INFO - PROCESS | 5564 | Values: 146.0 146.0 145.0 151.0 146.0 145.0 146.0 145.0 145.0 145.0 07:24:24 INFO - PROCESS | 5564 | 07:24:24 INFO - PROCESS | 5564 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 07:24:24 INFO - PROCESS | 5564 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 07:24:24 INFO - PROCESS | 5564 | 07:24:24 INFO - PROCESS | 5564 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:56.50 stddev:2.91 (5.1%) stddev-sans-first:3.08 07:24:24 INFO - PROCESS | 5564 | Values: 57.0 57.0 56.0 56.0 57.0 56.0 56.0 65.0 55.0 55.0 07:24:24 INFO - PROCESS | 5564 | 07:24:24 INFO - PROCESS | 5564 | [#9] json-stringify-tinderbox Cycles:10 Average:62.60 Median:62.50 stddev:0.97 (1.5%) stddev-sans-first:1.00 07:24:24 INFO - PROCESS | 5564 | Values: 62.0 62.0 65.0 62.0 62.0 63.0 63.0 62.0 63.0 62.0 07:24:24 INFO - PROCESS | 5564 | 07:24:24 INFO - PROCESS | 5564 | [#10] stanford-crypto-aes Cycles:10 Average:79.60 Median:79.50 stddev:2.41 (3.0%) stddev-sans-first:2.55 07:24:24 INFO - PROCESS | 5564 | Values: 79.0 80.0 78.0 80.0 78.0 78.0 78.0 79.0 80.0 86.0 07:24:24 INFO - PROCESS | 5564 | 07:24:24 INFO - PROCESS | 5564 | [#11] stanford-crypto-ccm Cycles:10 Average:116.50 Median:118.50 stddev:4.12 (3.5%) stddev-sans-first:4.33 07:24:24 INFO - PROCESS | 5564 | Values: 118.0 112.0 122.0 119.0 110.0 121.0 114.0 113.0 120.0 116.0 07:24:24 INFO - PROCESS | 5564 | 07:24:24 INFO - PROCESS | 5564 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.60 Median:143.00 stddev:3.75 (2.6%) stddev-sans-first:3.97 07:24:24 INFO - PROCESS | 5564 | Values: 143.0 144.0 143.0 153.0 142.0 143.0 146.0 140.0 140.0 142.0 07:24:24 INFO - PROCESS | 5564 | 07:24:24 INFO - PROCESS | 5564 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.00 Median:64.50 stddev:1.05 (1.6%) stddev-sans-first:1.05 07:24:24 INFO - PROCESS | 5564 | Values: 63.0 65.0 64.0 62.0 65.0 65.0 64.0 64.0 63.0 65.0 07:24:24 INFO - PROCESS | 5564 | -------- Summary: end -------- 07:24:24 INFO - PROCESS | 5564 | 07:24:25 INFO - TEST-INFO | 5564: exit 0 07:24:25 INFO - TEST-OK | kraken | took 59974ms 07:24:25 INFO - SUITE-END | took 1171s 07:24:25 INFO - Completed test suite (00:19:32) 07:24:25 INFO - javascript benchmark 07:24:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3045.695430456953, 3067.309855282562, 3083.7841351105426, 3091.8917837875665, 3124.906252812416, 5129.717865517395, 5132.538071573557, 5155.871103222416, 5196.792128314863, 5201.193814958678, 5219.765110570024, 5244.5542128919, 5276.445973172819, 5285.497877701622, 5290.629655924087, 4763.976180119103, 4781.995780886018, 4795.208790549573, 4824.927626085611, 4874.195757699975, 4727.054589082198, 4839.0, 4878.756062196893, 4886.609071274307, 4912.828051018215, 4628.051249493862, 4669.6731228814, 4705.623550115983, 4779.259214821691, 4788.0663270662235, 4751.833685821014, 4755.0, 4756.548127927841, 4762.761861906891, 4767.69010014348, 4728.05438912219, 4729.503402142795, 4729.69256998294, 4734.928976065362, 4735.526447355272, 5064.468230835783, 5149.485051494858, 5223.555997740196, 5240.895182096375, 5253.317068781034, 5510.421405752419, 5510.448955104457, 5524.806631767869, 5525.972370138124, 5526.281583394173, 5514.0901751211, 5565.749541270652, 5566.610337276392, 5573.749181286852, 5574.080276754331, 5193.480651934814, 5269.973650131763, 5340.54605358545, 5351.277577527062, 5354.785808567653, 5674.177244299553, 5689.288838895138, 5694.288213973254, 5711.857203569944, 5738.139279108083, 5472.863178420572, 5474.808381706621, 5476.12382018883, 5479.643823151482, 5483.7806487740845, 5416.377116631559, 5478.04134276508, 5547.750351234205, 5611.663300202001, 5618.634788738719, 5563.833085007456, 5570.192322113271, 5584.6090773646265, 5593.188987596775, 5595.328560572676, 5558.694271815089, 5585.413531579125, 5596.104623260258, 5596.86007849807, 5597.104463285936, 4190.51809041964, 4242.936355954663, 4262.573742625713, 4287.399764033038, 4297.226499230169, 3775.0373654717873, 3783.375743002374, 3791.1280405506886, 3822.6750726188584, 3823.2544653792243, 5163.948360516422, 5258.5267325940085, 5264.368275806928, 5266.947330526646, 5305.336832895888, 5587.720613969285, 5605.915911261334, 5609.27079479665, 5649.915251271234, 5661.264035675418, 5188.533032027136, 5234.979179060123, 5236.557210359474, 5237.0, 5240.528352448222, 4521.344405061248, 4613.861584152481, 4637.095766325601, 4640.814367425332, 4674.135284972291, 5618.85952851182, 5619.7471113799975, 5644.74598643062, 5648.181013753065, 5695.943040569541, 5479.0, 5483.0, 5492.4507549246355, 5497.092979658311, 5510.063289240758, 5593.272874526286, 5628.437156284339, 5677.574181936288, 5715.971420142872, 5761.222234998221, 5519.116941289374, 5521.723913804374, 5527.5577953762795, 5528.19841123043, 5530.004599172187, 5594.440555944373, 5607.495325420732, 5613.0, 5619.606627536196, 5624.409437009219, 5344.599155063308, 5438.320209973754, 5488.533474654699, 5513.862153446196, 5533.861653458695, 5436.53789427903, 5438.755256013568, 5440.836774896759, 5457.0, 5460.7542660579575, 5338.599605029716, 5389.730513474389, 5395.838124856261, 5403.486668766461, 5448.0, 5308.6283960123965, 5378.757955891916, 5470.097433923358, 5506.284183056177, 5537.473939975857, 5283.682979021271, 5338.572914166935, 5353.732313384237, 5353.78584856617, 5385.192221166856], "value": 5132.91389945757, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.3025449263413, 575.6488541989386, 578.7569220927207, 594.2215697436357, 597.1669521018179, 30674.0, 38711.0, 39586.0, 39634.40548391776, 39749.0, 41225.58774412255, 41717.37423938636, 41827.0, 41842.0, 41862.37206441898, 8523.0, 8722.345824063188, 8723.95638021809, 8730.650773969033, 8735.519546424945, 8574.69988550401, 8702.608382622766, 8704.129587041309, 8705.216530512253, 8710.47737135774, 8709.085546017672, 8967.41711788735, 8982.640694372218, 8983.910160898373, 8993.505357205351, 8878.733637990837, 8925.285977121815, 8928.553572321423, 8941.687040953568, 8944.060873608276, 8848.867266991001, 8971.237444817198, 8980.416272942302, 8982.820343593157, 8989.37074404792, 42673.1465370694, 43037.0, 43069.56930430687, 43149.68503149691, 43214.78392608017, 3415.4535274355985, 3622.0, 3762.6801721853676, 3959.221316583142, 4049.7570145791346, 32450.83774581112, 32762.508562371582, 32869.0, 33129.337413251844, 33136.50295245573, 4187.644050255732, 4208.179405016023, 4264.0, 4281.036766727492, 4292.763897985609, 292529.0, 292871.0, 293539.0, 293731.0, 293842.0, 60538.69730651407, 60709.392906070374, 60911.69544152251, 60928.0, 60996.0, 56606.716966415726, 58133.418665813646, 58255.41744582585, 69229.65385173041, 71161.64419177872, 16052.678946421007, 16191.433299834449, 16205.351785928431, 16216.75674864878, 16227.432039878784, 12273.631791046282, 12317.0, 12324.753504929851, 12333.198342107735, 12333.50665973369, 17877.553061173316, 19285.73191499859, 20058.197672092952, 20886.477838054172, 20890.477738056365, 7200.495965282485, 7231.349178573953, 7307.3058059484265, 7426.809091318074, 7561.584112873735, 1036.761544844675, 1112.659245609039, 1154.3535620052796, 1154.9942250288696, 1155.416514660108, 32914.50628240578, 32938.0, 32956.83521582377, 33020.339593208, 33534.66465335364, 1132.9263597866113, 1140.1448913315014, 1172.2263306217856, 1177.8056620657667, 1232.1929136415663, 16405.507834764976, 17341.219645116, 17998.280068797103, 18199.63600727978, 18280.26878924855, 577354.0, 585071.0, 586706.0, 586964.0, 587149.0, 61324.69337653372, 62672.05991910125, 62687.0, 62718.37281627217, 62762.0, 1400.859914008591, 1421.9360128794228, 1425.964350891236, 1430.6709456824988, 1434.9928250358682, 32300.515492267165, 34740.0, 34787.13032174216, 34975.13828703768, 35301.0, 51572.0, 51875.0, 52239.73880130575, 52288.477115229885, 52321.21518177154, 363581.0, 369234.0, 369353.0, 370162.0, 370748.0, 31780.36439271248, 37712.6800561979, 38023.42964855474, 38391.6160838388, 38392.6160738389, 45604.54395456003, 46033.079338413714, 46055.53944460512, 46058.0, 46164.7691761539, 38218.617813821504, 38403.0, 38723.031924200994, 39021.0, 40612.79693601513, 39883.40174897437, 40633.0, 41545.584544154175, 41914.58085419107, 42052.0, 41677.37483937804, 42421.363679544214, 42618.0, 42703.0, 42740.230068941535, 34410.31179376348, 35994.0, 36558.4516232262, 36586.26827463489, 36644.81677591595, 28294.448393976734, 28357.74788241156, 28588.713507891778, 28614.42771144607, 28691.232401581932], "value": 20278.58299492015, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.0669502810375, 373.34291646701803, 373.7757345592645, 375.61124236415316, 378.07749092214993, 17327.13364331783, 18547.16537755801, 19764.505887352825, 19769.11039003245, 19786.406407807754, 17856.196471158797, 18238.361657341997, 18597.814021859776, 18660.160292786823, 18670.813291867078, 5471.425500322469, 5516.668999860001, 5629.155626656014, 5644.153376993463, 5645.745941432625, 4034.8184331705143, 5495.917561236584, 5836.6206196597295, 6078.361772013941, 6120.785772497963, 6053.515718742512, 6065.0902364645435, 6088.695565221743, 6090.756369745205, 6091.42131497507, 5799.565032622549, 6077.969610151965, 6081.54388420868, 6083.0, 6084.391560843925, 3727.0682329417646, 5241.344831896013, 5384.461553844623, 5411.756470958777, 5413.810516631899, 20247.0, 20798.48003799902, 20862.53962222645, 20954.790452095436, 20978.685319720218, 2235.1506427557424, 2298.804601608865, 2330.2892617751577, 2479.330580743207, 2507.849529028246, 6924.6537673116645, 11977.101717371144, 12915.87084129156, 13245.86754132456, 13329.266890321029, 1923.778765441978, 1928.9131989060386, 1937.5931054478576, 1987.5130593004806, 2026.9087891044937, 67704.0, 67790.3220967789, 68139.65930170317, 68531.31468685299, 68593.0, 10099.343542669703, 10106.191504679608, 10191.7452063699, 10239.232057595711, 10502.842457363146, 13909.721805563831, 14012.369443375073, 14028.368723407471, 14047.08693934891, 14051.578452646438, 7761.72833950809, 7862.174471680506, 7934.285914267628, 7997.200279972072, 8036.799080023046, 7551.584662843597, 7574.697012119454, 7630.8855367169535, 7631.771046868603, 7741.1871753465075, 6141.385861413913, 6316.589421687576, 6351.841203969938, 6392.808215753535, 6400.263969643551, 1675.3298680527887, 1775.2810111904698, 1825.1056982078685, 1850.029718349953, 1859.1726681626546, 987.3434166279344, 1060.411471633251, 1095.5159127153227, 1191.541256616209, 1215.2423262925547, 17950.820491794915, 18646.81353186478, 18844.15201315944, 19330.03349832503, 19416.514587135152, 1032.9721926682998, 1041.7135287795916, 1053.2837670384213, 1081.313366012572, 1128.5711429656678, 10820.513076911559, 11351.37567433799, 11412.486438110305, 11430.771384572428, 11445.0, 466850.0, 471020.0, 478674.0, 481392.0, 482197.0, 69850.65074674696, 74400.62799685966, 74554.25445745581, 74790.62604686942, 76567.61716191383, 1034.7930413917247, 1042.1923009667416, 1053.9947300263602, 1074.3392813419691, 1083.3608171178885, 16918.746218806482, 16983.065931373894, 17081.82918170852, 17140.314387424365, 17214.39749608758, 36621.450678239315, 36785.26429471449, 36913.630863692095, 37439.43840842335, 37563.24873502569, 48047.0, 48436.757816210695, 48890.51109488859, 49009.50990490049, 49122.26316605325, 8186.672533098847, 8351.523203947876, 8502.574871256536, 8528.829423411373, 8556.058833528432, 9260.212881904845, 11932.701682458008, 12365.381730913597, 12636.42044744407, 13009.414576343897, 9414.246860251027, 11181.217314787888, 11347.148963827582, 11383.658490245305, 11439.542418303508, 7762.223777622193, 7961.800954976172, 11015.228933974866, 11448.313101213955, 11464.140189485655, 11488.19582629208, 11848.466818992994, 11901.880981190423, 11935.582254621047, 12036.63890083299, 8325.95837020811, 8347.666093356198, 8359.707410240855, 8533.701320453754, 8622.65509379643, 11045.171612129283, 11561.942190288995, 11596.246243994114, 11689.123315751183, 11789.056875450115], "value": 8975.651697287063, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1374.257900733604, 1499.3178103962698, 1505.4806091898295, 1663.168415792104, 1800.756897818794, 7955.522668639878, 8119.188081191885, 8120.350371970243, 8125.674973001072, 8131.918680813204, 7889.80275493113, 7914.881276780839, 7970.043594768621, 7971.0, 7975.561344126085, 2057.6913462980524, 2297.27635794725, 2333.1717240379676, 2356.4697942962866, 2356.6229403295474, 2361.327021798788, 2372.264597974625, 2374.25211058516, 2375.394274460019, 2378.120095564635, 2314.3982564533258, 2317.432229103872, 2373.845700029501, 2378.4053986503372, 2379.6073647848084, 2276.4195130241847, 2301.827362947786, 2317.617593097137, 2332.416895776056, 2334.1130370459286, 2298.276043046435, 2310.2145270608075, 2332.918347857817, 2338.0530884991604, 2376.821738369629, 8264.338852891755, 8329.125441828643, 8337.0, 8339.24946754795, 8353.37349698769, 5124.103281925685, 5249.527542521153, 5276.261323414687, 5284.709340986245, 5286.444923283077, 3363.899083027513, 3386.4750963600436, 3428.777129486575, 3458.9308213835584, 3460.1176699941607, 1087.130295763394, 1092.3882625729616, 1094.217634391406, 1127.6729748372961, 1154.4285578638544, 11645.708857278467, 11663.008644265248, 11705.063594912386, 11732.413379331, 11732.413379331085, 4600.0, 4621.329907163443, 4639.744814035261, 4673.7429441381055, 4692.0, 9844.0, 9882.950585247028, 9898.257630677728, 9898.30711850178, 9900.60397584103, 5211.166213405837, 5238.188080847474, 5256.894862102737, 5265.21021846726, 5269.314989051475, 4049.959500405017, 4609.262517997105, 4700.435947686299, 4708.976455117771, 4709.952900470951, 3797.9430308545393, 3853.614638536124, 3879.243547508209, 3904.882853514399, 3918.7060970427333, 1246.4141853328922, 1259.924404535731, 1271.2245530226555, 1272.332025686522, 1274.5411651805343, 1411.0968979852903, 1425.5081996711117, 1445.3206992713408, 1446.9638259043609, 1455.8980871338904, 7955.4828936118965, 8091.705327147628, 8096.0, 8103.473274237156, 8111.594420278962, 495.71744105860034, 506.71623890620634, 511.15148852904, 515.7421289355323, 516.6848222584221, 5957.731902064417, 5978.282606087298, 5980.461758441674, 6021.307549631761, 6031.095335699592, 9605.615775368908, 9615.51922403877, 9644.083812037845, 9738.610455581698, 9780.804383912282, 9436.480993545421, 9585.952070239744, 9603.327767056238, 9631.08504692053, 9636.036396360449, 7847.568383738835, 7966.6415011324625, 7997.960010200029, 8057.798555036171, 8065.838683226302, 7776.961115194388, 7842.333401660922, 7867.488613240121, 7895.131535531202, 7934.0, 8946.68686595966, 9211.631534738535, 9290.814183716422, 9293.070692930653, 9299.163075323253, 9239.38823505923, 9341.11259430353, 9395.389299695498, 9445.763855903657, 9501.717268168984, 6435.678216089271, 7153.856922861618, 7260.4554658401885, 7432.591207483641, 7554.320111190019, 7942.761717148494, 7948.284654381134, 7993.040835099825, 8005.159458257032, 8017.198280171936, 6966.164060312795, 7044.682989265598, 7060.293970603104, 7183.964080179775, 7415.592142432218, 6898.827529311808, 6949.444044476329, 7007.124109486314, 7087.397571206505, 7219.711211551479, 7049.541779784297, 7538.509996850187, 7544.132424771222, 7546.9622651888585, 7556.093268807778, 7017.228104908354, 7031.367176954099, 7032.578045317297, 7057.752978645723, 7064.788056358318, 6911.101556797584, 6932.306769323229, 6934.237233904166, 6937.445004399737, 6989.091418115612], "value": 4680.083112592163, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.0700362523, 347.2308835928419, 349.8810404462482, 350.1264345458082, 354.65066909094537, 5974.432428919251, 6000.7299671514775, 6019.608725432855, 6038.0, 6040.546958978072, 5927.110933359998, 5931.347551769302, 5935.910961335572, 5937.495312898398, 5974.611650242742, 4378.211921854065, 4474.8881277967985, 4580.679352445331, 4625.190591646457, 4632.143053535106, 4626.375439315683, 4630.564524997245, 4632.606228470584, 4641.744704041276, 4644.396228490308, 4588.334691469735, 4593.242115051013, 4602.12559613674, 4602.286645569925, 4614.007988282518, 4358.6077253047215, 4490.685652004361, 4562.498125206224, 4574.656900732459, 4617.353570500132, 4069.4506241657296, 4069.552349241581, 4078.9592104078874, 4079.653229475498, 4087.795610219477, 5712.57155713319, 5730.025895597759, 5730.484256416942, 5736.4550367715, 5738.942610573882, 5333.626646134772, 5334.679919204821, 5338.145896656516, 5339.5728341732565, 5344.973275133639, 6291.7168727406915, 6295.338989406138, 6300.968495157541, 6302.369763023661, 6302.96848515759, 4399.824007039714, 4499.235130027903, 4502.797374118172, 4509.729416235004, 4511.593956543927, 6472.644004579746, 6521.478281737497, 6524.412802847766, 6528.445082168021, 6539.901901471481, 4604.30935359692, 4605.102005109038, 4605.263157894721, 4607.723536587815, 4612.3542704021465, 4665.4168228971375, 4678.321643361762, 4683.391159149357, 4685.367475390779, 4689.906201875943, 5323.680579165262, 5324.281222035053, 5324.653897496651, 5331.30693009914, 5338.225957236179, 6067.908981365194, 6282.403171698681, 6297.181366422427, 6312.684365781693, 6321.399467050623, 1574.8976316539618, 1598.4964736108088, 1600.4798440506881, 1604.0536083710667, 1610.1385758619083, 982.7199248214224, 1040.6513817870946, 1050.4275170032352, 1051.9211059170593, 1072.0565902006185, 5967.791127310524, 6036.0, 6039.426254505903, 6070.605410648293, 6124.908126378108, 6418.807435776934, 6448.774292899726, 6454.19322584677, 6458.54790164684, 6460.903086453707, 6034.547408944259, 6035.66803825785, 6046.546509011841, 6092.908606370908, 6112.419320164578, 3446.3107378523896, 3484.094135524731, 3485.3203625292826, 3486.7210623150086, 3488.0, 6603.339666033455, 6643.900341494881, 6647.800565983028, 6811.557248778813, 6822.079019332426, 6710.295418980937, 6731.899021514681, 6739.966300168468, 6748.055272261888, 6760.628165450948, 6778.627175505395, 6789.1852977643985, 6795.490338224653, 6796.830079248059, 6808.387245147861, 6575.309592492719, 6580.5722628029025, 6594.0, 6594.670266486561, 6602.141721576357, 6330.683465826598, 6483.740650374121, 6494.350564943468, 6504.252011018793, 6512.120863683342, 6758.5606935550995, 6777.254502004874, 6784.118064651761, 6789.388954994074, 6791.694373753094, 4502.4371953505815, 4546.659000575036, 4554.089182163647, 4557.977210113928, 4561.064981678815, 6556.311587283267, 6562.442192413699, 6573.638449885302, 6575.0, 6582.506312026521, 6415.037744338387, 6427.389398007182, 6431.742730290736, 6438.903416448663, 6442.194725659293, 6225.439710426083, 6360.4911607072245, 6389.211020914151, 6395.456386207225, 6396.616203027833, 6250.156228909221, 6258.249010118815, 6266.404691554295, 6280.717367718372, 6282.811515654537, 6417.2299324081405, 6426.518011149089, 6428.774992875227, 6436.935630643821, 6438.0, 5967.701614919323, 6099.969500152471, 6272.153259309935, 6283.057541368831, 6296.087067375296], "value": 4799.249664759037, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [825.0264687668549, 841.3605659698628, 843.4475418600811, 865.9956700216497, 874.4884242718009, 14107.224102674349, 14337.354819033155, 15959.601009974756, 16200.270987805548, 16227.594310142253, 15344.0, 15429.228538573054, 15458.07251564907, 15495.690086198269, 15536.68926621467, 702.332783855337, 830.1366578758084, 835.1147783349653, 842.5071333270045, 847.6482259862149, 837.5142417397925, 840.4285086141422, 841.3521588376946, 841.9873701894477, 842.1031601344548, 879.9208071273584, 885.3404213860683, 885.3846576629245, 886.1448702002566, 886.246690313235, 725.0574253470494, 861.6294993152942, 869.2524428991063, 882.0738224863867, 883.1477624092781, 635.6440393379676, 638.113022898172, 638.1640051532507, 638.5976834594222, 640.0527219714802, 14173.574792756233, 14268.92865535676, 14290.285485725672, 14293.499727509487, 14435.494757683431, 13263.602091937257, 13479.393427295796, 13539.0, 13717.314134293345, 13802.65493362664, 10696.946515267375, 11169.553217871357, 11265.211435199539, 11417.657470275904, 11702.941485292604, 3739.2708421857747, 3800.068983099131, 3822.0827001519433, 3826.789526576037, 3852.537695476533, 54259.0, 54830.9999999996, 55128.448715513136, 55410.72294638542, 56142.43857561413, 10591.364518128938, 10671.092957098579, 10700.625478108228, 10728.356298622108, 10858.2399232053, 19305.324313649235, 19390.321338753078, 19992.60014799696, 20024.199032038556, 20076.498087547636, 8380.161983801692, 8460.8730869037, 8509.0, 8553.0, 8613.3109351253, 4924.532169443897, 4953.950460495421, 4975.0796102721115, 4978.502149785065, 5060.7216603086445, 3290.1445624137896, 3298.7855789373616, 3335.69978701918, 3336.9822204227944, 3345.882894098695, 515.2425933877195, 587.3568442555395, 626.0734113511937, 632.5761739634456, 635.2218532297898, 628.5914155798768, 701.5965819653719, 717.218232126984, 723.8841785314324, 732.7508647060025, 9101.635934562544, 9300.20948219409, 9396.765080872896, 9408.858867116998, 9578.90421095794, 725.5066554742825, 739.3087463221905, 749.5615065186927, 753.0887625972525, 754.7811134770855, 4243.533211346749, 4382.912341753147, 4410.0, 4507.661925355612, 4580.564846339593, 57777.71111144417, 58889.0, 58916.0, 61945.69027154835, 62021.68989155025, 48909.510904891205, 49837.50162498401, 49884.25173622399, 50279.0, 50658.0, 44198.11603767971, 44336.77831610821, 44371.77814110909, 44413.0, 45030.77484612556, 9339.766505837408, 9432.481213533321, 9437.669681561112, 9525.047495250697, 9954.452505111998, 34835.651643484256, 35682.28635427225, 36338.4549231767, 36463.0, 36790.63209367872, 42625.14749705051, 42831.35752963646, 43017.784911076495, 44882.326765099206, 45115.0, 11689.009643806074, 11783.351915644722, 11973.521059157536, 12005.159638825198, 12297.631071067883, 11802.586909458129, 11849.289042657469, 12746.872531274568, 13421.463141474622, 13489.797653035408, 12440.066994975232, 13143.671408214872, 13180.472781088649, 13241.602751917459, 13259.270740109387, 12096.637100886988, 12370.75258494843, 12977.870221297666, 12987.740245194855, 13006.934965325112, 12647.114701970773, 12721.236725796482, 13319.866801331862, 13401.932990335376, 13415.664608384868, 9537.284703647392, 9579.9042009579, 9854.310198286052, 9975.3017288792, 10174.287799853939, 8374.120717324593, 8385.454945428528, 8397.832043358976, 8453.36599755033, 8554.358423118416], "value": 6727.337168729049, "unit": "score"}], "name": "dromaeo_css", "value": 7215.999082241646, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 107.0, 109.0, 109.0, 112.0, 102.0, 111.0, 111.0, 109.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 126.0, 152.0, 168.0, 127.0, 152.0, 160.0, 128.0, 173.0, 134.0], "value": 146.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 163.0, 161.0, 162.0, 162.0, 162.0, 163.0, 170.0, 161.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 100.0, 103.0, 73.0, 72.0, 73.0, 130.0, 97.0, 75.0], "value": 87.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 138.0, 95.0, 93.0, 92.0, 136.0, 94.0, 92.0, 142.0], "value": 106.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 151.0, 146.0, 145.0, 146.0, 145.0, 145.0, 145.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 56.0, 56.0, 57.0, 56.0, 56.0, 65.0, 55.0, 55.0], "value": 57.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 65.0, 62.0, 62.0, 63.0, 63.0, 62.0, 63.0, 62.0], "value": 62.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 78.0, 80.0, 78.0, 78.0, 78.0, 79.0, 80.0, 86.0], "value": 79.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 112.0, 122.0, 119.0, 110.0, 121.0, 114.0, 113.0, 120.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 144.0, 143.0, 153.0, 142.0, 143.0, 146.0, 140.0, 140.0, 142.0], "value": 143.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 64.0, 62.0, 65.0, 65.0, 64.0, 64.0, 63.0, 65.0], "value": 64.0, "unit": "score"}], "name": "kraken", "value": 1493.6999999999998, "alertThreshold": 2.0}]} 07:24:25 INFO - Return code: 0 07:24:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 07:24:25 ERROR - # TBPL SUCCESS # 07:24:25 INFO - Running post-action listener: _resource_record_post_action 07:24:25 INFO - Running post-run listener: _resource_record_post_run 07:24:26 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 20480; Write bytes: 537300992; Read time: 260; Write time: 723488 07:24:26 INFO - install - Wall time: 17s; CPU: 16.0%; Read bytes: 4096; Write bytes: 243322880; Read time: 44; Write time: 460908 07:24:26 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 16384; Write bytes: 291889152; Read time: 216; Write time: 261592 07:24:26 INFO - Running post-run listener: _upload_blobber_files 07:24:26 INFO - Blob upload gear active. 07:24:26 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 07:24:26 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 07:24:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 07:24:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 07:24:26 INFO - (blobuploader) - INFO - Open directory for files ... 07:24:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:24:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:24:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:24:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:24:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:24:27 INFO - (blobuploader) - INFO - Done attempting. 07:24:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 07:24:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:24:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:24:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:24:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:24:28 INFO - (blobuploader) - INFO - Done attempting. 07:24:28 INFO - (blobuploader) - INFO - Iteration through files over. 07:24:28 INFO - Return code: 0 07:24:28 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 07:24:28 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 07:24:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/13ee7c60beb88993b31b1baa99738e08e4ecbccabd5107b00c308a0b4fe0309e4a432e40ed3e0e7ab95812ce1c14057d4a113bd33cab7bc31387d39d38c3ce8c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/224d06e46e4e633b25b21b8a9f1b06c127f8b651200d1974f895124b7c3d9dcdca0cd3b026f3838131095149e069ad4808d9c256cb8e94644eda36b16451c61c"} 07:24:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 07:24:28 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 07:24:28 INFO - Contents: 07:24:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/13ee7c60beb88993b31b1baa99738e08e4ecbccabd5107b00c308a0b4fe0309e4a432e40ed3e0e7ab95812ce1c14057d4a113bd33cab7bc31387d39d38c3ce8c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/224d06e46e4e633b25b21b8a9f1b06c127f8b651200d1974f895124b7c3d9dcdca0cd3b026f3838131095149e069ad4808d9c256cb8e94644eda36b16451c61c"} 07:24:28 INFO - Running post-run listener: copy_logs_to_upload_dir 07:24:28 INFO - Copying logs to upload dir... 07:24:28 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 07:24:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.989690 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-04-07 07:24:28.150923) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-07 07:24:28.154025) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=97facb8ba2ac28944cc45e6b000001d4-1460037833.121550-149164480 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/13ee7c60beb88993b31b1baa99738e08e4ecbccabd5107b00c308a0b4fe0309e4a432e40ed3e0e7ab95812ce1c14057d4a113bd33cab7bc31387d39d38c3ce8c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/224d06e46e4e633b25b21b8a9f1b06c127f8b651200d1974f895124b7c3d9dcdca0cd3b026f3838131095149e069ad4808d9c256cb8e94644eda36b16451c61c"} build_url:https://queue.taskcluster.net/v1/task/YhA9EenXQnG79snKGuSYig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011386 build_url: 'https://queue.taskcluster.net/v1/task/YhA9EenXQnG79snKGuSYig/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/Firefox/sha512/13ee7c60beb88993b31b1baa99738e08e4ecbccabd5107b00c308a0b4fe0309e4a432e40ed3e0e7ab95812ce1c14057d4a113bd33cab7bc31387d39d38c3ce8c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/224d06e46e4e633b25b21b8a9f1b06c127f8b651200d1974f895124b7c3d9dcdca0cd3b026f3838131095149e069ad4808d9c256cb8e94644eda36b16451c61c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-07 07:24:28.178375) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 07:24:28.178711) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=97facb8ba2ac28944cc45e6b000001d4-1460037833.121550-149164480 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004507 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 07:24:28.260386) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-07 07:24:28.260712) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-07 07:24:28.260995) ========= ========= Total master_lag: 0.25 =========