builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-033 starttime: 1458648157.63 results: success (0) buildid: 20160322023010 builduid: 6d70f58678264f53854a2f58a6c65da7 revision: 0c6bacea23968480ebb71482f6bedf54aaf23d55 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-22 05:02:37.634492) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-22 05:02:37.635135) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-22 05:02:37.635446) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1458647649.650103-1832580050 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006286 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-22 05:02:37.660784) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-22 05:02:37.661060) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-22 05:02:37.726758) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 05:02:37.727028) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1458647649.650103-1832580050 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004615 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 05:02:37.784656) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-22 05:02:37.784915) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-22 05:02:37.785227) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 05:02:37.785496) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1458647649.650103-1832580050 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-22 05:02:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 88.8M=0s 2016-03-22 05:02:38 (88.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.150574 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 05:02:37.950841) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 05:02:37.951113) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1458647649.650103-1832580050 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018494 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 05:02:38.002337) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 05:02:38.002656) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0c6bacea23968480ebb71482f6bedf54aaf23d55 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 0c6bacea23968480ebb71482f6bedf54aaf23d55 --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=edae0fb5fee9fb758e8af6d3000002a4-1458647649.650103-1832580050 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-22 05:02:38,162 truncating revision to first 12 chars 2016-03-22 05:02:38,162 Setting DEBUG logging. 2016-03-22 05:02:38,162 attempt 1/10 2016-03-22 05:02:38,162 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0c6bacea2396?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-22 05:02:38,557 unpacking tar archive at: fx-team-0c6bacea2396/testing/mozharness/ program finished with exit code 0 elapsedTime=0.676232 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 05:02:38.696085) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-22 05:02:38.696389) ========= echo 0c6bacea23968480ebb71482f6bedf54aaf23d55 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'0c6bacea23968480ebb71482f6bedf54aaf23d55'] 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=edae0fb5fee9fb758e8af6d3000002a4-1458647649.650103-1832580050 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 0c6bacea23968480ebb71482f6bedf54aaf23d55 program finished with exit code 0 elapsedTime=0.004695 script_repo_revision: '0c6bacea23968480ebb71482f6bedf54aaf23d55' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-22 05:02:38.747637) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-22 05:02:38.747905) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-22 05:02:38.762841) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-03-22 05:02:38.763097) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=edae0fb5fee9fb758e8af6d3000002a4-1458647649.650103-1832580050 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:02:39 INFO - MultiFileLogger online at 20160322 05:02:39 in /builds/slave/test-pgo 05:02:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:02:39 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:02:39 INFO - {'append_to_log': False, 05:02:39 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:02:39 INFO - 'blob_upload_branch': 'Fx-Team', 05:02:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:02:39 INFO - 'branch': 'Fx-Team', 05:02:39 INFO - 'buildbot_json_path': 'buildprops.json', 05:02:39 INFO - 'config_files': ('talos/linux_config.py',), 05:02:39 INFO - 'default_actions': ('clobber', 05:02:39 INFO - 'read-buildbot-config', 05:02:39 INFO - 'download-and-extract', 05:02:39 INFO - 'populate-webroot', 05:02:39 INFO - 'create-virtualenv', 05:02:39 INFO - 'install', 05:02:39 INFO - 'run-tests'), 05:02:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:02:39 INFO - 'download_minidump_stackwalk': True, 05:02:39 INFO - 'download_symbols': 'ondemand', 05:02:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:02:39 INFO - 'tooltool.py': '/tools/tooltool.py', 05:02:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:02:39 INFO - '/tools/misc-python/virtualenv.py')}, 05:02:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:02:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:02:39 INFO - 'installer_path': 'installer.exe', 05:02:39 INFO - 'log_level': 'info', 05:02:39 INFO - 'log_name': 'talos', 05:02:39 INFO - 'log_to_console': True, 05:02:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:02:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:02:39 INFO - 'opt_config_files': (), 05:02:39 INFO - 'pip_index': False, 05:02:39 INFO - 'sps_profile': False, 05:02:39 INFO - 'sps_profile_interval': 0, 05:02:39 INFO - 'suite': 'dromaeojs', 05:02:39 INFO - 'system_bits': '32', 05:02:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:02:39 INFO - 'title': 'talos-linux64-ix-033', 05:02:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:02:39 INFO - 'use_talos_json': True, 05:02:39 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:02:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:02:39 INFO - 'work_dir': 'build'} 05:02:39 INFO - ##### 05:02:39 INFO - ##### Running clobber step. 05:02:39 INFO - ##### 05:02:39 INFO - Running pre-action listener: _resource_record_pre_action 05:02:39 INFO - Running main action method: clobber 05:02:39 INFO - rmtree: /builds/slave/test-pgo/build 05:02:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:02:39 INFO - Running post-action listener: _resource_record_post_action 05:02:39 INFO - ##### 05:02:39 INFO - ##### Running read-buildbot-config step. 05:02:39 INFO - ##### 05:02:39 INFO - Running pre-action listener: _resource_record_pre_action 05:02:39 INFO - Running main action method: read_buildbot_config 05:02:39 INFO - Using buildbot properties: 05:02:39 INFO - { 05:02:39 INFO - "project": "", 05:02:39 INFO - "product": "firefox", 05:02:39 INFO - "script_repo_revision": "production", 05:02:39 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:02:39 INFO - "repository": "", 05:02:39 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 05:02:39 INFO - "buildid": "20160322023010", 05:02:39 INFO - "pgo_build": "True", 05:02:39 INFO - "basedir": "/builds/slave/test-pgo", 05:02:39 INFO - "buildnumber": 1021, 05:02:39 INFO - "slavename": "talos-linux64-ix-033", 05:02:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:02:39 INFO - "platform": "ubuntu64_hw", 05:02:39 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:02:39 INFO - "branch": "fx-team", 05:02:39 INFO - "repo_path": "integration/fx-team", 05:02:39 INFO - "revision": "0c6bacea23968480ebb71482f6bedf54aaf23d55", 05:02:39 INFO - "stage_platform": "linux64-pgo", 05:02:39 INFO - "builduid": "6d70f58678264f53854a2f58a6c65da7", 05:02:39 INFO - "slavebuilddir": "test" 05:02:39 INFO - } 05:02:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/NNKRAO9lTHSWme4Nzwdgyw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 05:02:39 INFO - Running post-action listener: _resource_record_post_action 05:02:39 INFO - ##### 05:02:39 INFO - ##### Running download-and-extract step. 05:02:39 INFO - ##### 05:02:39 INFO - Running pre-action listener: _resource_record_pre_action 05:02:39 INFO - Running main action method: download_and_extract 05:02:39 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:02:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:39 INFO - https://queue.taskcluster.net/v1/task/NNKRAO9lTHSWme4Nzwdgyw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:02:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NNKRAO9lTHSWme4Nzwdgyw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:02:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NNKRAO9lTHSWme4Nzwdgyw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:02:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NNKRAO9lTHSWme4Nzwdgyw/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 05:02:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NNKRAO9lTHSWme4Nzwdgyw/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 05:02:49 INFO - Downloaded 1361 bytes. 05:02:49 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:02:49 INFO - Using the following test package requirements: 05:02:49 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:02:49 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:02:49 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:02:49 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:02:49 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:02:49 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:02:49 INFO - u'jsshell-linux-x86_64.zip'], 05:02:49 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:02:49 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:02:49 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:02:49 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:02:49 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:02:49 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:02:49 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:02:49 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:02:49 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:02:49 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:02:49 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:02:49 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:02:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:49 INFO - https://queue.taskcluster.net/v1/task/NNKRAO9lTHSWme4Nzwdgyw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:02:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NNKRAO9lTHSWme4Nzwdgyw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:02:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NNKRAO9lTHSWme4Nzwdgyw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:02:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NNKRAO9lTHSWme4Nzwdgyw/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 05:02:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NNKRAO9lTHSWme4Nzwdgyw/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 05:02:55 INFO - Downloaded 23570463 bytes. 05:02:55 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'] 05:02:55 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 05:02:56 INFO - Return code: 0 05:02:56 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 05:02:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:56 INFO - https://queue.taskcluster.net/v1/task/NNKRAO9lTHSWme4Nzwdgyw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:02:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NNKRAO9lTHSWme4Nzwdgyw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:02:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NNKRAO9lTHSWme4Nzwdgyw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:02:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NNKRAO9lTHSWme4Nzwdgyw/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 05:02:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NNKRAO9lTHSWme4Nzwdgyw/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 05:02:59 INFO - Downloaded 23570463 bytes. 05:02:59 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'] 05:02:59 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 05:03:01 INFO - Return code: 0 05:03:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:01 INFO - https://queue.taskcluster.net/v1/task/NNKRAO9lTHSWme4Nzwdgyw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:03:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NNKRAO9lTHSWme4Nzwdgyw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:03:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NNKRAO9lTHSWme4Nzwdgyw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:03:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NNKRAO9lTHSWme4Nzwdgyw/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 05:03:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NNKRAO9lTHSWme4Nzwdgyw/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 05:03:02 INFO - Downloaded 10847637 bytes. 05:03:02 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'] 05:03:02 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 05:03:02 INFO - Return code: 0 05:03:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:02 INFO - https://queue.taskcluster.net/v1/task/NNKRAO9lTHSWme4Nzwdgyw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:03:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NNKRAO9lTHSWme4Nzwdgyw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:03:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NNKRAO9lTHSWme4Nzwdgyw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:03:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NNKRAO9lTHSWme4Nzwdgyw/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 05:03:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NNKRAO9lTHSWme4Nzwdgyw/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 05:03:04 INFO - Downloaded 57739190 bytes. 05:03:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NNKRAO9lTHSWme4Nzwdgyw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:03:04 INFO - mkdir: /builds/slave/test-pgo/properties 05:03:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:03:04 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:03:04 INFO - Contents: 05:03:04 INFO - build_url:https://queue.taskcluster.net/v1/task/NNKRAO9lTHSWme4Nzwdgyw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:03:05 INFO - Running post-action listener: _resource_record_post_action 05:03:05 INFO - Running post-action listener: set_extra_try_arguments 05:03:05 INFO - ##### 05:03:05 INFO - ##### Running populate-webroot step. 05:03:05 INFO - ##### 05:03:05 INFO - Running pre-action listener: _resource_record_pre_action 05:03:05 INFO - Running main action method: populate_webroot 05:03:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:03:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:03:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:03:05 INFO - '--tppagecycles', 05:03:05 INFO - '7'], 05:03:05 INFO - 'tests': ['tsvgm']}}, 05:03:05 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:03:05 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:03:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:03:05 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:03:05 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:03:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:03:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:03:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:05 INFO - 'talos_options': ['--e10s'], 05:03:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:03:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:05 INFO - 'tests': ['damp', 'tps']}, 05:03:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:05 INFO - 'talos_options': ['--e10s'], 05:03:05 INFO - 'tests': ['damp', 'tps']}, 05:03:05 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:03:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:03:05 INFO - 'other': {'tests': ['a11yr', 05:03:05 INFO - 'ts_paint', 05:03:05 INFO - 'tpaint', 05:03:05 INFO - 'sessionrestore', 05:03:05 INFO - 'sessionrestore_no_auto_restore', 05:03:05 INFO - 'tabpaint']}, 05:03:05 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:03:05 INFO - 'tests': ['a11yr', 05:03:05 INFO - 'ts_paint', 05:03:05 INFO - 'tpaint', 05:03:05 INFO - 'sessionrestore', 05:03:05 INFO - 'sessionrestore_no_auto_restore', 05:03:05 INFO - 'tabpaint']}, 05:03:05 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:03:05 INFO - 'tests': ['a11yr', 05:03:05 INFO - 'ts_paint', 05:03:05 INFO - 'tpaint', 05:03:05 INFO - 'sessionrestore', 05:03:05 INFO - 'sessionrestore_no_auto_restore', 05:03:05 INFO - 'tabpaint']}, 05:03:05 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:03:05 INFO - 'tests': ['a11yr', 05:03:05 INFO - 'ts_paint', 05:03:05 INFO - 'tpaint', 05:03:05 INFO - 'sessionrestore', 05:03:05 INFO - 'sessionrestore_no_auto_restore', 05:03:05 INFO - 'tabpaint']}, 05:03:05 INFO - 'other_l64': {'tests': ['a11yr', 05:03:05 INFO - 'ts_paint', 05:03:05 INFO - 'tpaint', 05:03:05 INFO - 'sessionrestore', 05:03:05 INFO - 'sessionrestore_no_auto_restore', 05:03:05 INFO - 'tabpaint']}, 05:03:05 INFO - 'other_nol64': {'tests': ['a11yr', 05:03:05 INFO - 'ts_paint', 05:03:05 INFO - 'tpaint', 05:03:05 INFO - 'sessionrestore', 05:03:05 INFO - 'sessionrestore_no_auto_restore', 05:03:05 INFO - 'tabpaint']}, 05:03:05 INFO - 'svgr': {'tests': ['tsvgx', 05:03:05 INFO - 'tsvgr_opacity', 05:03:05 INFO - 'tart', 05:03:05 INFO - 'tscrollx', 05:03:05 INFO - 'cart']}, 05:03:05 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:03:05 INFO - 'tests': ['tsvgx', 05:03:05 INFO - 'tsvgr_opacity', 05:03:05 INFO - 'tart', 05:03:05 INFO - 'tscrollx', 05:03:05 INFO - 'cart']}, 05:03:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:05 INFO - 'tests': ['tp5o']}, 05:03:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:05 INFO - 'talos_options': ['--e10s'], 05:03:05 INFO - 'tests': ['tp5o']}, 05:03:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:05 INFO - 'talos_options': ['--xperf_path', 05:03:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:03:05 INFO - 'tests': ['tp5n']}, 05:03:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:05 INFO - 'talos_options': ['--e10s', 05:03:05 INFO - '--xperf_path', 05:03:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:03:05 INFO - 'tests': ['tp5n']}}, 05:03:05 INFO - 'talos.zip': {'path': '', 05:03:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:03:05 INFO - Running post-action listener: _resource_record_post_action 05:03:05 INFO - ##### 05:03:05 INFO - ##### Running create-virtualenv step. 05:03:05 INFO - ##### 05:03:05 INFO - Running pre-action listener: _resource_record_pre_action 05:03:05 INFO - Running main action method: create_virtualenv 05:03:05 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:03:05 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 05:03:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:03:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:03:05 INFO - Using real prefix '/usr' 05:03:05 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:03:06 INFO - Installing distribute.............................................................................................................................................................................................done. 05:03:07 INFO - Installing pip.................done. 05:03:08 INFO - Return code: 0 05:03:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:03: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')]} 05:03:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03: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')]} 05:03:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:08 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 0x7fd4fd30ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdc6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd71d0>, '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 0x1fda750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fdabe0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1458647649.650103-1832580050', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:03:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 05:03:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:03:08 INFO - Using env: {'DISPLAY': ':0', 05:03:08 INFO - 'HOME': '/home/cltbld', 05:03:08 INFO - 'LANG': 'en_US.UTF-8', 05:03:08 INFO - 'LANGUAGE': 'en_US:en', 05:03:08 INFO - 'LOGNAME': 'cltbld', 05:03:08 INFO - 'MAIL': '/var/mail/cltbld', 05:03:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:08 INFO - 'MOZ_NO_REMOTE': '1', 05:03:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:03:08 INFO - 'NO_EM_RESTART': '1', 05:03:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:03:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:03:08 INFO - 'PWD': '/builds/slave/test-pgo', 05:03:08 INFO - 'SHELL': '/bin/bash', 05:03:08 INFO - 'SHLVL': '1', 05:03:08 INFO - 'TERM': 'linux', 05:03:08 INFO - 'TMOUT': '86400', 05:03:08 INFO - 'USER': 'cltbld', 05:03:08 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1458647649.650103-1832580050', 05:03:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:08 INFO - '_': '/tools/buildbot/bin/python'} 05:03:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:08 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:03:08 INFO - Cleaning up... 05:03:08 INFO - Return code: 0 05:03:08 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:03: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')]} 05:03:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03: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')]} 05:03:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:08 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 0x7fd4fd30ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdc6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd71d0>, '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 0x1fda750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fdabe0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1458647649.650103-1832580050', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:03:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:03:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:03:08 INFO - Using env: {'DISPLAY': ':0', 05:03:08 INFO - 'HOME': '/home/cltbld', 05:03:08 INFO - 'LANG': 'en_US.UTF-8', 05:03:08 INFO - 'LANGUAGE': 'en_US:en', 05:03:08 INFO - 'LOGNAME': 'cltbld', 05:03:08 INFO - 'MAIL': '/var/mail/cltbld', 05:03:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:08 INFO - 'MOZ_NO_REMOTE': '1', 05:03:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:03:08 INFO - 'NO_EM_RESTART': '1', 05:03:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:03:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:03:08 INFO - 'PWD': '/builds/slave/test-pgo', 05:03:08 INFO - 'SHELL': '/bin/bash', 05:03:08 INFO - 'SHLVL': '1', 05:03:08 INFO - 'TERM': 'linux', 05:03:08 INFO - 'TMOUT': '86400', 05:03:08 INFO - 'USER': 'cltbld', 05:03:08 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1458647649.650103-1832580050', 05:03:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:08 INFO - '_': '/tools/buildbot/bin/python'} 05:03:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:08 INFO - Downloading/unpacking psutil>=0.7.1 05:03:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:03:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:03:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:03:10 INFO - Installing collected packages: psutil 05:03:10 INFO - Running setup.py install for psutil 05:03:10 INFO - building 'psutil._psutil_linux' extension 05:03:10 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:03:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:03:10 INFO - building 'psutil._psutil_posix' extension 05:03:10 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:03:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:03:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:03:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:03:10 INFO - Successfully installed psutil 05:03:10 INFO - Cleaning up... 05:03:10 INFO - Return code: 0 05:03:10 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:03:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:10 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 0x7fd4fd30ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdc6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd71d0>, '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 0x1fda750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fdabe0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1458647649.650103-1832580050', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:03:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 05:03:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:03:10 INFO - Using env: {'DISPLAY': ':0', 05:03:10 INFO - 'HOME': '/home/cltbld', 05:03:10 INFO - 'LANG': 'en_US.UTF-8', 05:03:10 INFO - 'LANGUAGE': 'en_US:en', 05:03:10 INFO - 'LOGNAME': 'cltbld', 05:03:10 INFO - 'MAIL': '/var/mail/cltbld', 05:03:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:10 INFO - 'MOZ_NO_REMOTE': '1', 05:03:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:03:10 INFO - 'NO_EM_RESTART': '1', 05:03:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:03:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:03:10 INFO - 'PWD': '/builds/slave/test-pgo', 05:03:10 INFO - 'SHELL': '/bin/bash', 05:03:10 INFO - 'SHLVL': '1', 05:03:10 INFO - 'TERM': 'linux', 05:03:10 INFO - 'TMOUT': '86400', 05:03:10 INFO - 'USER': 'cltbld', 05:03:10 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1458647649.650103-1832580050', 05:03:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:10 INFO - '_': '/tools/buildbot/bin/python'} 05:03:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:11 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:03:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:12 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:03:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:03:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:03:13 INFO - Installing collected packages: mozsystemmonitor 05:03:13 INFO - Running setup.py install for mozsystemmonitor 05:03:13 INFO - Successfully installed mozsystemmonitor 05:03:13 INFO - Cleaning up... 05:03:13 INFO - Return code: 0 05:03:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:03:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03: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', '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 0x7fd4fd30ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdc6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd71d0>, '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 0x1fda750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fdabe0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1458647649.650103-1832580050', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:03: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 05:03: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 blobuploader==1.2.4 05:03:13 INFO - Using env: {'DISPLAY': ':0', 05:03:13 INFO - 'HOME': '/home/cltbld', 05:03:13 INFO - 'LANG': 'en_US.UTF-8', 05:03:13 INFO - 'LANGUAGE': 'en_US:en', 05:03:13 INFO - 'LOGNAME': 'cltbld', 05:03:13 INFO - 'MAIL': '/var/mail/cltbld', 05:03:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:13 INFO - 'MOZ_NO_REMOTE': '1', 05:03:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:03:13 INFO - 'NO_EM_RESTART': '1', 05:03:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:03:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:03:13 INFO - 'PWD': '/builds/slave/test-pgo', 05:03:13 INFO - 'SHELL': '/bin/bash', 05:03:13 INFO - 'SHLVL': '1', 05:03:13 INFO - 'TERM': 'linux', 05:03:13 INFO - 'TMOUT': '86400', 05:03:13 INFO - 'USER': 'cltbld', 05:03:13 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1458647649.650103-1832580050', 05:03:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:13 INFO - '_': '/tools/buildbot/bin/python'} 05:03:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:13 INFO - Downloading/unpacking blobuploader==1.2.4 05:03:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:15 INFO - Downloading blobuploader-1.2.4.tar.gz 05:03:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:03:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:03:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:03:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:03:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:15 INFO - Downloading docopt-0.6.1.tar.gz 05:03:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:03:16 INFO - Installing collected packages: blobuploader, requests, docopt 05:03:16 INFO - Running setup.py install for blobuploader 05:03:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:03:16 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:03:16 INFO - Running setup.py install for requests 05:03:16 INFO - Running setup.py install for docopt 05:03:16 INFO - Successfully installed blobuploader requests docopt 05:03:16 INFO - Cleaning up... 05:03:16 INFO - Return code: 0 05:03:16 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:03: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')]} 05:03:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03: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')]} 05:03:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:16 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 0x7fd4fd30ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdc6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd71d0>, '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 0x1fda750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fdabe0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1458647649.650103-1832580050', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:03:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:03:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:03:16 INFO - Using env: {'DISPLAY': ':0', 05:03:16 INFO - 'HOME': '/home/cltbld', 05:03:16 INFO - 'LANG': 'en_US.UTF-8', 05:03:16 INFO - 'LANGUAGE': 'en_US:en', 05:03:16 INFO - 'LOGNAME': 'cltbld', 05:03:16 INFO - 'MAIL': '/var/mail/cltbld', 05:03:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:16 INFO - 'MOZ_NO_REMOTE': '1', 05:03:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:03:16 INFO - 'NO_EM_RESTART': '1', 05:03:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:03:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:03:16 INFO - 'PWD': '/builds/slave/test-pgo', 05:03:16 INFO - 'SHELL': '/bin/bash', 05:03:16 INFO - 'SHLVL': '1', 05:03:16 INFO - 'TERM': 'linux', 05:03:16 INFO - 'TMOUT': '86400', 05:03:16 INFO - 'USER': 'cltbld', 05:03:16 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1458647649.650103-1832580050', 05:03:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:16 INFO - '_': '/tools/buildbot/bin/python'} 05:03:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:03:16 INFO - Running setup.py (path:/tmp/pip-IP7bQD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:03:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:03:16 INFO - Running setup.py (path:/tmp/pip-oTuaAx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:03:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:03:16 INFO - Running setup.py (path:/tmp/pip-4hatho-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:03:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:03:17 INFO - Running setup.py (path:/tmp/pip-q2HMDe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:03:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:03:17 INFO - Running setup.py (path:/tmp/pip-FLr4zk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:03:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:03:17 INFO - Running setup.py (path:/tmp/pip-8DEAZI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:03:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:03:17 INFO - Running setup.py (path:/tmp/pip-lNBQzY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:03:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:03:17 INFO - Running setup.py (path:/tmp/pip-O7qxEL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:03:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:03:17 INFO - Running setup.py (path:/tmp/pip-hnf0tB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:03:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:03:17 INFO - Running setup.py (path:/tmp/pip-2jkkW4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:03:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:03:17 INFO - Running setup.py (path:/tmp/pip-FXh50B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:03:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:03:17 INFO - Running setup.py (path:/tmp/pip-VJAyN_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:03:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:03:17 INFO - Running setup.py (path:/tmp/pip-p8fWZ5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:03:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:03:17 INFO - Running setup.py (path:/tmp/pip-3POrIW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:03:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:03:17 INFO - Running setup.py (path:/tmp/pip-4rZNJB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:03:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:03:17 INFO - Running setup.py (path:/tmp/pip-bORB62-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:03:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:03:18 INFO - Running setup.py (path:/tmp/pip-QdwRv_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:03:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:03:18 INFO - Running setup.py install for manifestparser 05:03:18 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:03:18 INFO - Running setup.py install for mozcrash 05:03:18 INFO - Running setup.py install for mozdebug 05:03:18 INFO - Running setup.py install for mozdevice 05:03:18 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:03:18 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:03:18 INFO - Running setup.py install for mozfile 05:03:18 INFO - Running setup.py install for mozhttpd 05:03:18 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:03:18 INFO - Running setup.py install for mozinfo 05:03:18 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:03:18 INFO - Running setup.py install for mozInstall 05:03:18 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:03:18 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:03:18 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:03:18 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:03:18 INFO - Running setup.py install for mozleak 05:03:19 INFO - Running setup.py install for mozlog 05:03:19 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:03:19 INFO - Running setup.py install for moznetwork 05:03:19 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:03:19 INFO - Running setup.py install for mozprocess 05:03:19 INFO - Running setup.py install for mozprofile 05:03:19 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:03:19 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:03:19 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:03:19 INFO - Running setup.py install for mozrunner 05:03:19 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:03:19 INFO - Running setup.py install for mozscreenshot 05:03:19 INFO - Running setup.py install for moztest 05:03:19 INFO - Running setup.py install for mozversion 05:03:19 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:03:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:03:19 INFO - Cleaning up... 05:03:19 INFO - Return code: 0 05:03:19 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:03:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:19 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 0x7fd4fd30ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdc6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd71d0>, '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 0x1fda750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fdabe0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1458647649.650103-1832580050', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:03:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:03:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:03:19 INFO - Using env: {'DISPLAY': ':0', 05:03:19 INFO - 'HOME': '/home/cltbld', 05:03:19 INFO - 'LANG': 'en_US.UTF-8', 05:03:19 INFO - 'LANGUAGE': 'en_US:en', 05:03:19 INFO - 'LOGNAME': 'cltbld', 05:03:19 INFO - 'MAIL': '/var/mail/cltbld', 05:03:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:19 INFO - 'MOZ_NO_REMOTE': '1', 05:03:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:03:19 INFO - 'NO_EM_RESTART': '1', 05:03:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:03:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:03:19 INFO - 'PWD': '/builds/slave/test-pgo', 05:03:19 INFO - 'SHELL': '/bin/bash', 05:03:19 INFO - 'SHLVL': '1', 05:03:19 INFO - 'TERM': 'linux', 05:03:19 INFO - 'TMOUT': '86400', 05:03:19 INFO - 'USER': 'cltbld', 05:03:19 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1458647649.650103-1832580050', 05:03:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:19 INFO - '_': '/tools/buildbot/bin/python'} 05:03:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:03:20 INFO - Running setup.py (path:/tmp/pip-97rlUc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:03:20 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 05:03:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:03:20 INFO - Running setup.py (path:/tmp/pip-9HPA_k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:03:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:03:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:03:20 INFO - Running setup.py (path:/tmp/pip-I7ZFRl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:03:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:03:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:03:20 INFO - Running setup.py (path:/tmp/pip-9MEEfL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:03:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:03:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:03:20 INFO - Running setup.py (path:/tmp/pip-0i51fm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:03:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 05:03:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:03:20 INFO - Running setup.py (path:/tmp/pip-fsiATB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:03:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 05:03:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:03:20 INFO - Running setup.py (path:/tmp/pip-uXpPyD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:03:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 05:03:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:03:20 INFO - Running setup.py (path:/tmp/pip-g0SOu5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:03:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 05:03:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:03:20 INFO - Running setup.py (path:/tmp/pip-kWMrnJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:03:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 05:03:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:03:20 INFO - Running setup.py (path:/tmp/pip-Ig60WK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:03:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:03:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:03:20 INFO - Running setup.py (path:/tmp/pip-lhfecU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:03:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 05:03:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:03:20 INFO - Running setup.py (path:/tmp/pip-wvtOQb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:03:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 05:03:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:03:20 INFO - Running setup.py (path:/tmp/pip-A3QRFn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:03:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 05:03:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:03:21 INFO - Running setup.py (path:/tmp/pip-R5jdvq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:03:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 05:03:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:03:21 INFO - Running setup.py (path:/tmp/pip-Quj2JM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:03:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 05:03:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:03:21 INFO - Running setup.py (path:/tmp/pip-HgWgHI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:03:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 05:03:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:03:21 INFO - Running setup.py (path:/tmp/pip-3LTZqj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:03:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 05:03:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:03:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:03:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:03:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:03:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:03:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:03: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 05:03: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 05:03: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 05:03: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 05:03: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 05:03: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 05:03:23 INFO - Downloading blessings-1.6.tar.gz 05:03:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:03:23 INFO - Installing collected packages: blessings 05:03:23 INFO - Running setup.py install for blessings 05:03:23 INFO - Successfully installed blessings 05:03:23 INFO - Cleaning up... 05:03:23 INFO - Return code: 0 05:03:23 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:03:23 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:03:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:03:23 INFO - Reading from file tmpfile_stdout 05:03:23 INFO - Current package versions: 05:03:23 INFO - argparse == 1.2.1 05:03:23 INFO - blessings == 1.6 05:03:23 INFO - blobuploader == 1.2.4 05:03:23 INFO - docopt == 0.6.1 05:03:23 INFO - manifestparser == 1.1 05:03:23 INFO - mozInstall == 1.12 05:03:23 INFO - mozcrash == 0.17 05:03:23 INFO - mozdebug == 0.1 05:03:23 INFO - mozdevice == 0.48 05:03:23 INFO - mozfile == 1.2 05:03:23 INFO - mozhttpd == 0.7 05:03:23 INFO - mozinfo == 0.9 05:03:23 INFO - mozleak == 0.1 05:03:23 INFO - mozlog == 3.1 05:03:23 INFO - moznetwork == 0.27 05:03:23 INFO - mozprocess == 0.22 05:03:23 INFO - mozprofile == 0.28 05:03:23 INFO - mozrunner == 6.11 05:03:23 INFO - mozscreenshot == 0.1 05:03:23 INFO - mozsystemmonitor == 0.0 05:03:23 INFO - moztest == 0.7 05:03:23 INFO - mozversion == 1.4 05:03:23 INFO - psutil == 3.1.1 05:03:23 INFO - requests == 1.2.3 05:03:23 INFO - wsgiref == 0.1.2 05:03:23 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:03:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:23 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 0x7fd4fd30ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdc6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd71d0>, '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 0x1fda750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fdabe0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1458647649.650103-1832580050', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:03:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 05:03:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:03:23 INFO - Using env: {'DISPLAY': ':0', 05:03:23 INFO - 'HOME': '/home/cltbld', 05:03:23 INFO - 'LANG': 'en_US.UTF-8', 05:03:23 INFO - 'LANGUAGE': 'en_US:en', 05:03:23 INFO - 'LOGNAME': 'cltbld', 05:03:23 INFO - 'MAIL': '/var/mail/cltbld', 05:03:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:23 INFO - 'MOZ_NO_REMOTE': '1', 05:03:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:03:23 INFO - 'NO_EM_RESTART': '1', 05:03:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:03:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:03:23 INFO - 'PWD': '/builds/slave/test-pgo', 05:03:23 INFO - 'SHELL': '/bin/bash', 05:03:23 INFO - 'SHLVL': '1', 05:03:23 INFO - 'TERM': 'linux', 05:03:23 INFO - 'TMOUT': '86400', 05:03:23 INFO - 'USER': 'cltbld', 05:03:23 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1458647649.650103-1832580050', 05:03:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:23 INFO - '_': '/tools/buildbot/bin/python'} 05:03:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:03:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 05:03:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 05:03:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:03:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 05:03:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 05:03:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 05:03:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 05:03:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 05:03:23 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:03:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:03:23 INFO - Cleaning up... 05:03:23 INFO - Return code: 0 05:03:23 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:03:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:23 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 0x7fd4fd30ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdc6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd71d0>, '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 0x1fda750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fdabe0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1458647649.650103-1832580050', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:03:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 05:03:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:03:23 INFO - Using env: {'DISPLAY': ':0', 05:03:23 INFO - 'HOME': '/home/cltbld', 05:03:23 INFO - 'LANG': 'en_US.UTF-8', 05:03:23 INFO - 'LANGUAGE': 'en_US:en', 05:03:23 INFO - 'LOGNAME': 'cltbld', 05:03:23 INFO - 'MAIL': '/var/mail/cltbld', 05:03:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:23 INFO - 'MOZ_NO_REMOTE': '1', 05:03:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:03:23 INFO - 'NO_EM_RESTART': '1', 05:03:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:03:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:03:23 INFO - 'PWD': '/builds/slave/test-pgo', 05:03:23 INFO - 'SHELL': '/bin/bash', 05:03:23 INFO - 'SHLVL': '1', 05:03:23 INFO - 'TERM': 'linux', 05:03:23 INFO - 'TMOUT': '86400', 05:03:23 INFO - 'USER': 'cltbld', 05:03:23 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1458647649.650103-1832580050', 05:03:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:23 INFO - '_': '/tools/buildbot/bin/python'} 05:03:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:24 INFO - Downloading/unpacking jsonschema 05:03:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:03:25 INFO - Downloading/unpacking functools32 (from jsonschema) 05:03:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:26 INFO - Downloading functools32-3.2.3-2.tar.gz 05:03:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:03:26 INFO - warning: no files found matching '*.txt' 05:03:26 INFO - no previously-included directories found matching 'build' 05:03:26 INFO - no previously-included directories found matching 'dist' 05:03:26 INFO - no previously-included directories found matching '.git*' 05:03:26 INFO - Installing collected packages: jsonschema, functools32 05:03:26 INFO - Running setup.py install for functools32 05:03:26 INFO - warning: no files found matching '*.txt' 05:03:26 INFO - no previously-included directories found matching 'build' 05:03:26 INFO - no previously-included directories found matching 'dist' 05:03:26 INFO - no previously-included directories found matching '.git*' 05:03:26 INFO - Successfully installed jsonschema functools32 05:03:26 INFO - Cleaning up... 05:03:26 INFO - Return code: 0 05:03:26 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:03:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:26 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 0x7fd4fd30ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdc6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd71d0>, '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 0x1fda750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fdabe0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1458647649.650103-1832580050', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:03:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 05:03:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:03:26 INFO - Using env: {'DISPLAY': ':0', 05:03:26 INFO - 'HOME': '/home/cltbld', 05:03:26 INFO - 'LANG': 'en_US.UTF-8', 05:03:26 INFO - 'LANGUAGE': 'en_US:en', 05:03:26 INFO - 'LOGNAME': 'cltbld', 05:03:26 INFO - 'MAIL': '/var/mail/cltbld', 05:03:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:26 INFO - 'MOZ_NO_REMOTE': '1', 05:03:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:03:26 INFO - 'NO_EM_RESTART': '1', 05:03:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:03:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:03:26 INFO - 'PWD': '/builds/slave/test-pgo', 05:03:26 INFO - 'SHELL': '/bin/bash', 05:03:26 INFO - 'SHLVL': '1', 05:03:26 INFO - 'TERM': 'linux', 05:03:26 INFO - 'TMOUT': '86400', 05:03:26 INFO - 'USER': 'cltbld', 05:03:26 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1458647649.650103-1832580050', 05:03:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:26 INFO - '_': '/tools/buildbot/bin/python'} 05:03:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:26 INFO - Downloading/unpacking flake8 05:03: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 05:03: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 05:03: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 05:03: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 05:03: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 05:03: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 05:03:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:03:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:03:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:03:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:03:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:03:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:03:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:03:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:03:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:03:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:03:29 INFO - no previously-included directories found matching 'docs/_build' 05:03:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:03:29 INFO - Running setup.py install for pep8 05:03:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:03:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:03:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:03:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:03:29 INFO - no previously-included directories found matching 'docs/_build' 05:03:29 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:03:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:03:29 INFO - Cleaning up... 05:03:29 INFO - Return code: 0 05:03:29 INFO - Running post-action listener: _resource_record_post_action 05:03:29 INFO - Running post-action listener: _start_resource_monitoring 05:03:29 INFO - Starting resource monitoring. 05:03:29 INFO - ##### 05:03:29 INFO - ##### Running install step. 05:03:29 INFO - ##### 05:03:29 INFO - Running pre-action listener: _resource_record_pre_action 05:03:29 INFO - Running main action method: install 05:03:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:03:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:03:29 INFO - Reading from file tmpfile_stdout 05:03:29 INFO - Detecting whether we're running mozinstall >=1.0... 05:03:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:03:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:03:29 INFO - Reading from file tmpfile_stdout 05:03:29 INFO - Output received: 05:03:29 INFO - Usage: mozinstall [options] installer 05:03:29 INFO - Options: 05:03:29 INFO - -h, --help show this help message and exit 05:03:29 INFO - -d DEST, --destination=DEST 05:03:29 INFO - Directory to install application into. [default: 05:03:29 INFO - "/builds/slave/test-pgo"] 05:03:29 INFO - --app=APP Application being installed. [default: firefox] 05:03:29 INFO - mkdir: /builds/slave/test-pgo/build/application 05:03:29 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'] 05:03:29 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 05:03:46 INFO - Reading from file tmpfile_stdout 05:03:46 INFO - Output received: 05:03:46 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:03:46 INFO - Running post-action listener: _resource_record_post_action 05:03:46 INFO - ##### 05:03:46 INFO - ##### Running run-tests step. 05:03:46 INFO - ##### 05:03:46 INFO - Running pre-action listener: _resource_record_pre_action 05:03:46 INFO - Running main action method: run_tests 05:03:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:03:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:03:46 INFO - Python 2.7.3 05:03:46 INFO - Return code: 0 05:03:46 INFO - grabbing minidump binary from tooltool 05:03:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:46 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 0x1fd71d0>, '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 0x1fda750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fdabe0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:03:46 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 05:03:46 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:03:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:03:46 INFO - Return code: 0 05:03:46 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:03:46 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:03:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:03:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:03:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:03:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:03:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:03:47 INFO - Return code: 0 05:03:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NNKRAO9lTHSWme4Nzwdgyw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 05:03:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NNKRAO9lTHSWme4Nzwdgyw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 05:03:47 INFO - Using env: {'DISPLAY': ':0', 05:03:47 INFO - 'HOME': '/home/cltbld', 05:03:47 INFO - 'LANG': 'en_US.UTF-8', 05:03:47 INFO - 'LANGUAGE': 'en_US:en', 05:03:47 INFO - 'LOGNAME': 'cltbld', 05:03:47 INFO - 'MAIL': '/var/mail/cltbld', 05:03:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:03:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:03:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:47 INFO - 'MOZ_NO_REMOTE': '1', 05:03:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:03:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:03:47 INFO - 'NO_EM_RESTART': '1', 05:03:47 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:03:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:03:47 INFO - 'PWD': '/builds/slave/test-pgo', 05:03:47 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:03:47 INFO - 'SHELL': '/bin/bash', 05:03:47 INFO - 'SHLVL': '1', 05:03:47 INFO - 'TERM': 'linux', 05:03:47 INFO - 'TMOUT': '86400', 05:03:47 INFO - 'USER': 'cltbld', 05:03:47 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1458647649.650103-1832580050', 05:03:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:47 INFO - '_': '/tools/buildbot/bin/python'} 05:03:47 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NNKRAO9lTHSWme4Nzwdgyw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:03:47 INFO - mozversion application_buildid: 20160322023010 05:03:47 INFO - mozversion application_changeset: 0c6bacea23968480ebb71482f6bedf54aaf23d55 05:03:47 INFO - mozversion application_display_name: Nightly 05:03:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:03:47 INFO - mozversion application_name: Firefox 05:03:47 INFO - mozversion application_remotingname: firefox 05:03:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:03:47 INFO - mozversion application_vendor: Mozilla 05:03:47 INFO - mozversion application_version: 48.0a1 05:03:47 INFO - mozversion platform_buildid: 20160322023010 05:03:47 INFO - mozversion platform_changeset: 0c6bacea23968480ebb71482f6bedf54aaf23d55 05:03:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:03:47 INFO - mozversion platform_version: 48.0a1 05:03:47 INFO - using testdate: 1458648227 05:03:47 INFO - actual date: 1458648227 05:03:47 INFO - starting webserver on 'localhost:55389' 05:03:47 INFO - SUITE-START | Running 2 tests 05:03:47 INFO - TEST-START | dromaeo_css 05:03:47 INFO - operating with platform_type : linux_ 05:03:47 INFO - Initialising browser for dromaeo_css test... 05:03:47 INFO - TEST-INFO | started process 25467 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7KguBV/profile http://localhost:55389/getInfo.html) 05:03:52 INFO - PROCESS | 25467 | __metrics Screen width/height:1600/1200 05:03:52 INFO - PROCESS | 25467 | colorDepth:24 05:03:52 INFO - PROCESS | 25467 | Browser inner width/height: 1024/697 05:03:52 INFO - PROCESS | 25467 | __metrics 05:03:53 ERROR - PROCESS | 25467 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:03:53 INFO - PROCESS | 25467 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 05:03:54 INFO - TEST-INFO | 25467: exit 0 05:03:54 INFO - Browser initialized. 05:03:54 INFO - Running cycle 1/1 for dromaeo_css test... 05:03:54 INFO - TEST-INFO | started process 25562 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7KguBV/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:04:06 INFO - PROCESS | 25562 | RSS: Main: 156712960 05:04:06 INFO - PROCESS | 25562 | 05:04:56 INFO - PROCESS | 25562 | 1458648296829 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:07:04 INFO - PROCESS | 25562 | Cycle 1(1): loaded http://localhost:55389/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55389/tests/dromaeo/cssquery-ext.html) 05:07:05 INFO - PROCESS | 25562 | RSS: Main: 258273280 05:07:05 INFO - PROCESS | 25562 | 05:10:07 INFO - PROCESS | 25562 | Cycle 1(1): loaded http://localhost:55389/tests/dromaeo/cssquery-ext.html (next: http://localhost:55389/tests/dromaeo/cssquery-jquery.html) 05:10:08 INFO - PROCESS | 25562 | RSS: Main: 228675584 05:10:08 INFO - PROCESS | 25562 | 05:13:10 INFO - PROCESS | 25562 | Cycle 1(1): loaded http://localhost:55389/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55389/tests/dromaeo/cssquery-mootools.html) 05:13:10 INFO - PROCESS | 25562 | RSS: Main: 230322176 05:13:10 INFO - PROCESS | 25562 | 05:16:12 INFO - PROCESS | 25562 | Cycle 1(1): loaded http://localhost:55389/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55389/tests/dromaeo/cssquery-prototype.html) 05:16:13 INFO - PROCESS | 25562 | RSS: Main: 222957568 05:16:13 INFO - PROCESS | 25562 | 05:19:15 INFO - PROCESS | 25562 | Cycle 1(1): loaded http://localhost:55389/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55389/tests/dromaeo/cssquery-yui.html) 05:19:16 INFO - PROCESS | 25562 | RSS: Main: 224628736 05:19:16 INFO - PROCESS | 25562 | 05:22:18 INFO - PROCESS | 25562 | Cycle 1(1): loaded http://localhost:55389/tests/dromaeo/cssquery-yui.html (next: http://localhost:55389/tests/dromaeo/cssquery-dojo.html) 05:22:18 INFO - PROCESS | 25562 | RSS: Main: 272080896 05:22:18 INFO - PROCESS | 25562 | 05:22:18 INFO - PROCESS | 25562 | __start_tp_report 05:22:18 INFO - PROCESS | 25562 | _x_x_mozilla_page_load 05:22:18 INFO - PROCESS | 25562 | _x_x_mozilla_page_load_details 05:22:18 INFO - PROCESS | 25562 | |i|pagename|runs| 05:22:18 INFO - PROCESS | 25562 | |0;dojo.html;3066.4633689104407;3079.9230019249503;3119.3917186148697;3122.67211942746;3157.905262842114;5184.481551844814;5251.054810134175;5257.7108259045735;5285.603579731516;5297.284866543016;5288.550473209782;5292.947070529293;5293.232481290211;5334.5999050071305;5350.892982140354;4744.312074749159;4746;4753.310769938357;4761.880952976168;4936.35827342445;4865.051314993578;4877.658563900528;4889.7066176029375;4921.064997650453;4947.925781113287;4719.952800472003;4740.549647783472;4789.568938795525;4830.686005409672;4843.975780121112;4751.40607424072;4763.737994410306;4769.308450274691;4775;4807.399075115611;4666.32338310943;4722.362481065046;4725.978506563031;4751.738654374008;4805.927911081337;5113.437521872591;5167.405748338914;5170.922436163461;5177.844664660066;5199.948000520022;5569.777208911639;5570.6657600543695;5573.665580065209;5575.69333686647;5592.5246354059955;5569.582281328876;5580.86047848803;5581.776728930838;5585.05054140793;5613.10190369543;5220.504052115043;5250.317458730379;5250.343707036659;5255.76349064293;5309.601779866487;5783.190353350535;5788.160716696056;5800;5801.53587712982;5811.476967072984;5338.679679219259;5448.210009548593;5517.834464966058;5528;5533.723313834292;5592.972035139798;5596.748146333425;5598.300212473441;5605.439456054443;5624.240727501817;5570.248016517799;5588.21764952907;5588.776448941997;5588.776448941997;5602.38373778884;5431.321084864392;5549.19536667181;5566.165075238747;5684.715764211773;5721.399253078367;4113.074558224375;4119.0526178979;4119.340905455113;4123.711340206157;4159.708820382604;3714.2200137971327;3715.6841668458483;3716.7769933804057;3727.8508859645854;3740.0649837540614;5255.842324730188;5316.229146773696;5355.705436201047;5396.514313711707;5401.459854014567;5629.802956896489;5638.4925356718095;5644.294463192101;5662.37713851476;5678.261825962599;5251.36983561975;5354.491323324278;5368.2752828367675;5368.436314187033;5412.134058550613;4799.688020278671;4810.302506136591;4821.686590371684;4864.270359446041;4867.050925069578;5744.569157313218;5750.712464376765;5755.85610359736;5756.251687280626;5757.078867381283;5548.278723765885;5560.7219639018695;5564.415736347625;5567.47109024642;5619.8314050579365;5856.707164641665;5861.648301101947;5886.52907767369;5893.174955506147;5940.346561878104;5576.5817563683695;5583.860403489945;5588.077967135378;5589.9938011156755;5590.161475778666;5486.753096110605;5672.829815105553;5674.233978412862;5675.4892059713175;5775.595708300379;5492.176173573996;5495.477929596682;5497.202905578749;5498.780048798003;5531.059719847555;5456.781728730806;5461.262729531462;5462.808801691922;5464.316960379952;5512.173174023928;5133;5376.973115134399;5390.137577987503;5459.69971651563;5489.64317319373;5536.695481748542;5546.306711661043;5549.056660367666;5551.7779288828;5564.443555644403;5419.783208671609;5432.158015507603;5432.239486471976;5434.945650543602;5445.809396671098 05:22:18 INFO - PROCESS | 25562 | |1;ext.html;557.3089369182213;562.4459906991614;572.2303501790091;584.6141546579257;595.7914729844553;29907.252318692015;37968.62031379689;38352;38419.231615367746;38423.231535369276;41077.58922410775;41416.17167656645;41543.58456415442;41625;41689.37465938006;7928.326092282134;8631.913680863174;8798.780030499225;8802.119788021211;8811.030786613468;8017.278444939954;10480.842787358195;10729.892701073006;10746.140308775279;10747;10418.583256669725;10514.316569423001;10530.104941080017;10539.051485366315;10546.367217966908;10320.071193592537;10320.380777153357;10380.584776608926;10392.272540922138;10400.271980961335;10256.07695307426;10303.690889273334;10369.481525923673;10374.533146008447;10385.740356491073;41633.167336653096;42087.789561052305;42196.57803421957;42231.577684223375;42241;3380.915477113067;3458.913527161816;3498.860045598173;3517.8944631661093;3893.5133108361456;31826.840865795522;32060.19849503781;32384.352312953844;32494.83752581222;32553.186170345693;4178.958210417887;4259.616634502879;4273.764942928137;4297.67767417445;4334.436523251957;326540;327048;327560;327662;328702.9999999976;47613.047739045025;47767.283490747664;47844.521554784704;47847.65066445385;61366;45898.311525327146;46215;46227;46396.30405543919;46481.30278045832;15617.609559761097;15713.842861571238;15769.132697701507;15769.763453548207;15771.369145234292;12331.630051098482;12370.257784532956;12402.13185077036;12408.441620127116;12556.686082848002;16073.115978621288;16112.75830862538;16294.42969496062;16305.836941630669;16308.266128024268;6113.205283313141;6267.310595834455;6299.433051025429;6316.778912738124;6338.7464501420345;1031.3811712972306;1046.3146638951498;1053.073295499955;1077.42357838556;1143.9599614013468;31840.840795795873;32603.347933041205;32668.673313267038;32767.344653106804;32989.67010329914;982.1553464020936;1069.4866464097122;1094.768385566238;1122.859642544682;1131.4060118437885;14511.346989385504;15059.247037648074;15286;15335.386584536494;17402.303907843798;467932;473673;474060;474555;475231;59513.70243148757;59529.40470595239;59545.106823397684;59627.40372596305;59667;1300.4148133340034;1405.669667628086;1405.845357010728;1422.7723564229673;1455.7743549749805;28249.293767655974;29122.98069567555;29475.557866632447;30029.24926876758;30381.69618303877;42056.369154462096;42430.57569424266;42482.57517424786;42545;42601.786991064844;290277;297653;297914;297964;298323;30566.388672226876;34858.302833943686;34979;35199.296014080086;35712.642873570934;41133;42028.36957445702;49381.25928111153;50057;50478.49521504738;36385;36648.63351366559;36722.63277367192;36982;37089.44365834461;35609;35740;35869.282614347045;35984.28031439304;36024.81987590045;36950.6304936958;37204;37635.43546846745;37969.810150949066;38031.61968380392;34622.480662790585;36570;37325.25349493049;37399.25201496009;38164.618353816106;26137.954481820514;26317.21048368552;26464.470710586065;26501.60247596249;28349.716502834708 05:22:18 INFO - PROCESS | 25562 | |2;jquery.html;369.7485709717391;373.3298728781837;376.69864108713034;376.9415740560214;381.36883457877224;18465.44603661889;18638.161282742276;19315.323963661238;19402.611947761055;19410.611787764235;17992.280308787635;18359.44921652349;18955.90522047388;19021.334253301102;19101.42695719127;5506.834794956148;5640.915386269188;5661.631993920402;5665.490105890469;5675.801346952858;4136.193442278757;5580.469855363734;5958.195643588104;6229.314775374728;6248.562600617958;6133.509319254449;6169.845753856144;6183.227096612924;6199.194104766374;6202.317745048041;5946.791862284799;6124.203853499062;6129.478994285491;6132.049532322497;6132.049532322497;3783.810809459516;5284.4187139414635;5367.329083864517;5449.700266485342;5463.726813659301;22102.88948555263;22575.548489030127;22653.32040038785;22773;22911.770882291297;2318.2813327868416;2344.953100937989;2580.729023452548;3003.354278830062;3051.633803943541;13878.583642490741;14117.294135293194;14249.857501424956;14444.205568693718;14580.635484112981;1919.2131226197332;1977.4561995451222;2008.1164287713505;2014.3453377652322;2016.596680663873;66849.3315066848;68987;69023.65488172577;69146.30853691448;69591.3040869595;10471.3193642413;10530.104581175461;10603.310784798963;10822.621208257673;10952.233343665866;13980.650483737987;14010.229437380838;14093.15441073539;14103.153810771386;14107.647308817157;8051.315638170821;8309.626066827008;8382.07797142314;8504.404691671523;8523.95738021306;8326.45878017927;8392.748217553482;8457.746267611981;8530.189631984951;8534.573271336409;6578.473722102221;6674.132362792806;6690.431313338323;6694.966525167343;6706.094677218513;1728.8357606027407;1753.3687872365938;1763.4709587123812;1767.5050985724017;1850.7316439116253;987.6790043235977;1032.396048311731;1042.593388578455;1063.8989296016866;1114.9275297105662;18125.728114078298;18427.81572184288;18699.532511687044;18912.90543547301;19017.144228509474;1026.1277913773383;1063;1075.8224892892742;1095.7151140703315;1118.3010618363523;10493;10730.624428145133;10732;10808;10921;496781;512385;522842;523012;526637.934482624;64080;67583;67749;68121.31878681149;68426.65786671035;1088.2110469909253;1095.6822521468684;1096.2381145104237;1096.780643871229;1117.2793548161553;16208.270627822012;16237.67524649524;16249.26878290456;16506.504804855875;16529.66940661156;33656.49515257224;34552.13619659529;35164.296714066084;35204.823975879954;35276.11809704778;44520.554794451644;45908;46208.07583848372;46254.537454625024;46783.76608116938;8039.638216280398;8040.87938680932;8110.472819266729;8150.510969341858;8158.265756081981;12424.75150497003;12479.126461147996;12603.369831508204;12652.17760845542;12714.173578717353;11155.382469542034;11381.374024428736;11382.487788049391;11527.596534121265;11701.06391488696;11103.38931358783;11196.328220306808;11222.326660400402;11333.603323883954;11510.13673974472;11266.718332041764;11524.59663911759;11573.652790415965;11682.649520514398;11700.765984680429;7610.961945190239;7911.960440197992;8002.399820013406;8056.919430805617;8242.629081691219;10750.354978701303;10790.460476976277;11092.667219983414;11160.944195278971;11232.494537745657 05:22:18 INFO - PROCESS | 25562 | |3;mootools.html;1335.3959778432047;1466;1491.6420059185791;1680.722680757675;1853.8424233940113;7577.696892124315;7792;7813.765587032398;7817.022872140989;7845.686172553105;7791.571463569501;7923.6830526779;7930.484518506293;7935.722249721261;7952.403569732264;1998.8400927925804;2264.705588273522;2293.747687754346;2295.908163673451;2345.8240631952585;2354.9175778847743;2366.8461549999283;2367.6330168823774;2367.7750613691674;2369.3484291819714;2229.1863469833474;2321.6401457773986;2322.2336628912503;2323.6514522821544;2327.3250757280452;2275.613145765224;2301.723793144825;2356;2357.6463530470483;2359.905603775847;2319.8724070176136;2326.348622385735;2335.544568809083;2343.6836027136287;2358.9738463768317;7961.283484486424;7985.960070199611;8004.599770011476;8011.399145064143;8014.959925200336;4939.259111133323;5017.698938063728;5056.797728090872;5057.519535644108;5058.064258112261;3360.8487618057247;3448.3448144852396;3507.91230219244;3517.314123745871;3529.4882242074755;1207.6618546806908;1219.8780121987818;1223.3883058470765;1241.2924632959216;1281.980770288437;11056.336619802838;11185.608503702413;11207.887921120766;11212.383318917457;11242.213045086848;4399.5380485049245;4486.1252055849445;4542.046170304207;4553.362529245908;4563.520830312769;9502;9532.761680958032;9535.52322383878;9553.808923821485;9593.040695930351;4475.462944446687;5003.449620541737;5036;5044.545990860766;5045.5459008689395;4478.888027799331;4481.170983368087;4580.1755683976535;4585.358049873021;4585.885352866205;3851.2297540491454;3908.218356328746;3923.7841918694176;3927.842886284574;3946.625070618287;1242.4595301044076;1261.4954018392716;1264.4626033935724;1267.0623738433492;1276.3809552367095;1328.7807511760645;1338.9263590502617;1344.8386193656825;1347.5351003903834;1351.8783309502192;7344.706211751577;7424.183339832614;7627.733029343946;7637;7650.923490765133;1136.5851464215666;1136.9658910232706;1151.758130792543;1153.7058050197145;1169.5672601137633;5651.802186923438;5665.9716701417055;5710.371859095496;5722.313322401338;5730.656160630376;9486.098820612031;9774.218062555121;9909.20726341891;9939.055789699967;10082.193424526167;9646.469444180497;9921.702348929544;9928.205743540499;9946.055124763136;9974.152197063331;7487.737929172453;7712.691492340356;7753.7286194984035;7777;7783.922160778433;7231.819204519718;7333.596652184181;7346.77959661211;7361.779146625609;7381.630918454163;8741;8742.300615950835;8833.205011548991;8989.28085753125;9029.187373136449;8254.339652827639;9009.954950225207;9122.315826313186;9149.176574108362;9165.495897725688;6453.580517266362;6721.764738234334;6919.238883722685;7081.114860642419;7197.244289349543;7418.109826820816;7432.962835185789;7448.813779655336;7469.141048779243;7490.4007679386605;6643.30245324234;6799.830004249933;6834.179898412222;6859.9314006859295;6969.128858892638;6832.419244364086;6835.555688880207;6878.759243426456;6915;6923;7079.539829911039;7122;7150.785476435715;7159.57042577447;7242.96378518104;6638.800835974928;6651.401373876374;6683.63240021784;6688.565243259172;6697.430718388991;6607.702653380513;6608.768693095911;6655.900161497679;6670.199576050905;6687.63218022994 05:22:18 INFO - PROCESS | 25562 | |4;prototype.html;341.9144217110674;343.0771225403664;346.20373141773916;349.19510528232416;352.0529774905506;5968.432998865112;5988.640681559104;5994.0709190075495;6010.789622363218;6040;5950.315713692927;5958.642481451116;5965.015772397549;5971.1043343498495;5984.581079324438;4357.063231405239;4447.733136011833;4490.169318676056;4498.617617502517;4532.4787649420405;4532.52408497108;4558.38461807655;4574.702644328125;4597.310403439494;4606.654500912428;4558.316252562109;4563.338315944186;4566.356111799766;4567.58891699747;4568.428946381702;4344.847930322455;4435.778211089465;4519.638428925678;4523.683342166049;4558.794854231551;3987.2424239394713;3997.040710229524;3998.080441498472;4001.379786133154;4005.719599628027;5662.263905692274;5685.431456854281;5773.711314434261;5776.624519406225;5781.942180578182;5344.305240318772;5345.412004679482;5348.465153484621;5359.196120581905;5365.007473617355;6289.905651415233;6312;6316.96841515794;6318.810435686937;6320.115183874262;4372.081862808814;4434.600885920283;4464.575865292792;4466.307722303049;4468.642508599337;6620.503462240303;6664.266930637626;6668.666566671647;6686.531942764009;6701.530892837503;4584.518625544337;4590.5638964299005;4592.104539614743;4592.10453961481;4593;4645.837395691135;4646.767661616906;4648.372469716613;4649.163150632919;4652.162610730101;5319.654222475527;5322.3879253885525;5324.227986941872;5326.6005049621435;5331.306930099062;6187.319394866561;6360;6363.522735794834;6368.331325210786;6370.235571731329;1577.4163559483065;1593.5219434169935;1603.711331960235;1605.3739041773717;1606.3173151410604;1002.9197664186994;1048.8636477257908;1069.417167643636;1089.1776708584969;1107.1198397274186;6027.939720602825;6037;6050.152978583002;6125.785597504066;6142.447179753844;6496.870062598721;6519.967400162969;6521.771737989147;6522.380373864476;6527.640979746065;6084.665343406155;6157.230346206724;6159.938400616026;6172.753089876444;6172.938270617236;3492.161881148506;3529.8764543240864;3530.135116896377;3534.6111927687934;3534.8232588370993;6582.670866456658;6721.1598550181225;6731.528792984444;6743.224529179109;6747.527673062937;6639.4024537790865;6651.866962660816;6657.933420665731;6659.833504162435;6669.2997235289595;6704.430123439464;6711;6713.798586042427;6714.328567143247;6716.697748601325;6489.318621544859;6492.5455218134275;6495.447886929664;6507.056476810931;6517.283098859217;6369.936300636934;6411.5832470889245;6419.679016049272;6422.197225346832;6570.605763654196;6840.623765692736;6864.141982252218;6865.931340686529;6866.073080134118;6872.484563657646;4469.128519938711;4507.233770259129;4508.774561271857;4512.932306015478;4521.276595744665;6602.636854973022;6626.53614246998;6630.502712296694;6631.867362652816;6640.966795165993;6373.776917807854;6458.806235812933;6463.967680161569;6464.450521705708;6481.805545833632;6363.3636636336;6417.71120299597;6423.678816059271;6423.743050277936;6425.550211485338;6256.874862502816;6280.685965701788;6292.9370706294185;6294.968525157345;6309.621422714652;6435.581687190318;6490.772822951174;6508.056331831953;6513.088167656437;6516.641584712696;6000.369961154191;6096.177016102769;6289.40250676185;6289.465395441256;6295.748170073146 05:22:18 INFO - PROCESS | 25562 | |5;yui.html;762.3786613909665;820.7414664380719;829.9626516806743;855.8972923249211;868.7002983970532;13372.665683357922;13437.596872093853;13512.662183445394;13579.864201357983;13583.93208033961;13047.869521304785;13482.595522134352;13555.864441355583;13583.592492225249;13589.252591107484;678.7149397253165;686.7802303262957;824.0893812337371;837.8826964225013;841.5834162089774;848.5375470368664;850.8936382952131;851.6721062390963;851.8509260879322;852.7100785732849;892.6117139044504;895.3150839607705;896.4666023715911;896.9641214351418;897.1432282170512;716.6739133694183;875.3784812782932;888.0054339140172;888.0453512474052;888.7778055486128;647.4981889035988;648.7696867611977;648.8410339466814;649.6881496881523;649.9967500162469;13308.733825323536;13329;13341.733165336736;13354.26551539665;13387.397567109503;13889.861101388959;14342.856571434257;14378.496752613713;14424.639384015378;14562.053466524749;11318.886811131866;11488.712782180428;11488.827667584992;12379.938100309531;12702;3860.613938606145;3868.6711629511524;3884.533855937277;3920.313945059632;3953.743006704584;51595.48404515944;52042;52114;52341.738291308684;52362.47637523576;10909.127269818555;11135.554577816796;11223.326600404002;11370.772584548262;11970;20028.499287517636;20190.192392304143;20203.8989805053;20501.692474612893;20554;8549.27331176857;8784.912150878537;8836.337274704423;8877.911220887838;9062.275017998545;4811.639127065414;4928.28539861718;4978.825741099116;5018.824341148043;5031.622628302892;3208.51872219169;3245.659205783406;3248.7725859190105;3250.934981300361;3270.967290327114;610.6763415389851;625.2465778736612;626.6428135962549;629.8110566829932;654.1398061549048;741.6551303643831;778.8870613760973;786.1431040166246;787.5314188058096;803.7468197517763;9096.408733432438;9386.5776040077;9695.757606059906;9865.408075515492;9865.605375785031;745.3366503811612;751.3125490176427;755.1014292991323;760.9086909570776;769.4229328003997;4230.767307798039;4264.445622069174;4392.692511524163;4399.098184872094;4461.330800379969;56835.71582142063;58729;60492.18523444304;60856;61474.692626536584;53152;54035.729821350644;55442.44557554454;55649.72175139179;55913.44086559083;44813.775931120785;46421.535784642394;46483.76758116255;48352;51259.743701282;9824.263180261652;9865.605375784888;9939.453330066915;9981.500924953869;10029.899701003189;35635.82182089073;36941.815290924445;37557.62442375541;37793;38079.80960095182;44822.3276650857;45261.32108018317;49420.27042460548;49448.25827612517;49573.504264958334;11836.171467997157;11900.464479098287;11916.940415298215;12075.577354792891;12186.086043546593;11162.218644694793;13231.867681323063;13575.52485662997;14151.363188656329;14266.358013889192;12237.388130593612;12575.811362829749;12621.621351359474;13040.934795325962;13155.93422032922;11922.284662920252;12058.879411206126;12144.089193310361;12199;12204.877951220375;11574.826377604175;11773.47019384147;12204.267743935392;12208.145429819828;12557.058220633306;10224.846627300745;10621.362718236931;10656.733581660521;10667.146628269564;11001.779964400826;10144.746381340525;10336.638217662347;10345.068943795095;10390.22073344487;10409.11522520564 05:22:18 INFO - PROCESS | 25562 | __end_tp_report 05:22:18 INFO - PROCESS | 25562 | __start_cc_report 05:22:18 INFO - PROCESS | 25562 | _x_x_mozilla_cycle_collect,801 05:22:18 INFO - PROCESS | 25562 | __end_cc_report 05:22:18 INFO - PROCESS | 25562 | __startTimestamp1458649338934__endTimestamp 05:22:18 INFO - PROCESS | 25562 | 05:22:18 INFO - PROCESS | 25562 | ------- Summary: start ------- 05:22:18 INFO - PROCESS | 25562 | Number of tests: 6 05:22:18 INFO - PROCESS | 25562 | 05:22:18 INFO - PROCESS | 25562 | [#0] dojo.html Cycles:165 Average:5215.37 Median:5432.24 stddev:600.53 (11.1%) stddev-sans-first:578.22 05:22:18 INFO - PROCESS | 25562 | Values: 3066.5 3079.9 3119.4 3122.7 3157.9 5184.5 5251.1 5257.7 5285.6 5297.3 5288.6 5292.9 5293.2 5334.6 5350.9 4744.3 4746.0 4753.3 4761.9 4936.4 4865.1 4877.7 4889.7 4921.1 4947.9 4720.0 4740.5 4789.6 4830.7 4844.0 4751.4 4763.7 4769.3 4775.0 4807.4 4666.3 4722.4 4726.0 4751.7 4805.9 5113.4 5167.4 5170.9 5177.8 5199.9 5569.8 5570.7 5573.7 5575.7 5592.5 5569.6 5580.9 5581.8 5585.1 5613.1 5220.5 5250.3 5250.3 5255.8 5309.6 5783.2 5788.2 5800.0 5801.5 5811.5 5338.7 5448.2 5517.8 5528.0 5533.7 5593.0 5596.7 5598.3 5605.4 5624.2 5570.2 5588.2 5588.8 5588.8 5602.4 5431.3 5549.2 5566.2 5684.7 5721.4 4113.1 4119.1 4119.3 4123.7 4159.7 3714.2 3715.7 3716.8 3727.9 3740.1 5255.8 5316.2 5355.7 5396.5 5401.5 5629.8 5638.5 5644.3 5662.4 5678.3 5251.4 5354.5 5368.3 5368.4 5412.1 4799.7 4810.3 4821.7 4864.3 4867.1 5744.6 5750.7 5755.9 5756.3 5757.1 5548.3 5560.7 5564.4 5567.5 5619.8 5856.7 5861.6 5886.5 5893.2 5940.3 5576.6 5583.9 5588.1 5590.0 5590.2 5486.8 5672.8 5674.2 5675.5 5775.6 5492.2 5495.5 5497.2 5498.8 5531.1 5456.8 5461.3 5462.8 5464.3 5512.2 5133.0 5377.0 5390.1 5459.7 5489.6 5536.7 5546.3 5549.1 5551.8 5564.4 5419.8 5432.2 5432.2 5434.9 5445.8 05:22:18 INFO - PROCESS | 25562 | 05:22:18 INFO - PROCESS | 25562 | [#1] ext.html Cycles:180 Average:52579.41 Median:3508.38 stddev:98633.59 (2811.4%) stddev-sans-first:98832.95 05:22:18 INFO - PROCESS | 25562 | Values: 557.3 562.4 572.2 584.6 595.8 29907.3 37968.6 38352.0 38419.2 38423.2 41077.6 41416.2 41543.6 41625.0 41689.4 7928.3 8631.9 8798.8 8802.1 8811.0 8017.3 10480.8 10729.9 10746.1 10747.0 10418.6 10514.3 10530.1 10539.1 10546.4 10320.1 10320.4 10380.6 10392.3 10400.3 10256.1 10303.7 10369.5 10374.5 10385.7 41633.2 42087.8 42196.6 42231.6 42241.0 3380.9 3458.9 3498.9 3517.9 3893.5 31826.8 32060.2 32384.4 32494.8 32553.2 4179.0 4259.6 4273.8 4297.7 4334.4 326540.0 327048.0 327560.0 327662.0 328703.0 47613.0 47767.3 47844.5 47847.7 61366.0 45898.3 46215.0 46227.0 46396.3 46481.3 15617.6 15713.8 15769.1 15769.8 15771.4 12331.6 12370.3 12402.1 12408.4 12556.7 16073.1 16112.8 16294.4 16305.8 16308.3 6113.2 6267.3 6299.4 6316.8 6338.7 1031.4 1046.3 1053.1 1077.4 1144.0 31840.8 32603.3 32668.7 32767.3 32989.7 982.2 1069.5 1094.8 1122.9 1131.4 14511.3 15059.2 15286.0 15335.4 17402.3 467932.0 473673.0 474060.0 474555.0 475231.0 59513.7 59529.4 59545.1 59627.4 59667.0 1300.4 1405.7 1405.8 1422.8 1455.8 28249.3 29123.0 29475.6 30029.2 30381.7 42056.4 42430.6 42482.6 42545.0 42601.8 290277.0 297653.0 297914.0 297964.0 298323.0 30566.4 34858.3 34979.0 35199.3 35712.6 41133.0 42028.4 49381.3 50057.0 50478.5 36385.0 36648.6 36722.6 36982.0 37089.4 35609.0 35740.0 35869.3 35984.3 36024.8 36950.6 37204.0 37635.4 37969.8 38031.6 34622.5 36570.0 37325.3 37399.3 38164.6 26138.0 26317.2 26464.5 26501.6 28349.7 05:22:18 INFO - PROCESS | 25562 | 05:22:18 INFO - PROCESS | 25562 | [#2] jquery.html Cycles:180 Average:28166.16 Median:22614.43 stddev:84290.30 (372.7%) stddev-sans-first:84500.92 05:22:18 INFO - PROCESS | 25562 | Values: 369.7 373.3 376.7 376.9 381.4 18465.4 18638.2 19315.3 19402.6 19410.6 17992.3 18359.4 18955.9 19021.3 19101.4 5506.8 5640.9 5661.6 5665.5 5675.8 4136.2 5580.5 5958.2 6229.3 6248.6 6133.5 6169.8 6183.2 6199.2 6202.3 5946.8 6124.2 6129.5 6132.0 6132.0 3783.8 5284.4 5367.3 5449.7 5463.7 22102.9 22575.5 22653.3 22773.0 22911.8 2318.3 2345.0 2580.7 3003.4 3051.6 13878.6 14117.3 14249.9 14444.2 14580.6 1919.2 1977.5 2008.1 2014.3 2016.6 66849.3 68987.0 69023.7 69146.3 69591.3 10471.3 10530.1 10603.3 10822.6 10952.2 13980.7 14010.2 14093.2 14103.2 14107.6 8051.3 8309.6 8382.1 8504.4 8524.0 8326.5 8392.7 8457.7 8530.2 8534.6 6578.5 6674.1 6690.4 6695.0 6706.1 1728.8 1753.4 1763.5 1767.5 1850.7 987.7 1032.4 1042.6 1063.9 1114.9 18125.7 18427.8 18699.5 18912.9 19017.1 1026.1 1063.0 1075.8 1095.7 1118.3 10493.0 10730.6 10732.0 10808.0 10921.0 496781.0 512385.0 522842.0 523012.0 526637.9 64080.0 67583.0 67749.0 68121.3 68426.7 1088.2 1095.7 1096.2 1096.8 1117.3 16208.3 16237.7 16249.3 16506.5 16529.7 33656.5 34552.1 35164.3 35204.8 35276.1 44520.6 45908.0 46208.1 46254.5 46783.8 8039.6 8040.9 8110.5 8150.5 8158.3 12424.8 12479.1 12603.4 12652.2 12714.2 11155.4 11381.4 11382.5 11527.6 11701.1 11103.4 11196.3 11222.3 11333.6 11510.1 11266.7 11524.6 11573.7 11682.6 11700.8 7611.0 7912.0 8002.4 8056.9 8242.6 10750.4 10790.5 11092.7 11160.9 11232.5 05:22:18 INFO - PROCESS | 25562 | 05:22:18 INFO - PROCESS | 25562 | [#3] mootools.html Cycles:180 Average:5644.44 Median:6092.12 stddev:2901.97 (47.6%) stddev-sans-first:2892.03 05:22:18 INFO - PROCESS | 25562 | Values: 1335.4 1466.0 1491.6 1680.7 1853.8 7577.7 7792.0 7813.8 7817.0 7845.7 7791.6 7923.7 7930.5 7935.7 7952.4 1998.8 2264.7 2293.7 2295.9 2345.8 2354.9 2366.8 2367.6 2367.8 2369.3 2229.2 2321.6 2322.2 2323.7 2327.3 2275.6 2301.7 2356.0 2357.6 2359.9 2319.9 2326.3 2335.5 2343.7 2359.0 7961.3 7986.0 8004.6 8011.4 8015.0 4939.3 5017.7 5056.8 5057.5 5058.1 3360.8 3448.3 3507.9 3517.3 3529.5 1207.7 1219.9 1223.4 1241.3 1282.0 11056.3 11185.6 11207.9 11212.4 11242.2 4399.5 4486.1 4542.0 4553.4 4563.5 9502.0 9532.8 9535.5 9553.8 9593.0 4475.5 5003.4 5036.0 5044.5 5045.5 4478.9 4481.2 4580.2 4585.4 4585.9 3851.2 3908.2 3923.8 3927.8 3946.6 1242.5 1261.5 1264.5 1267.1 1276.4 1328.8 1338.9 1344.8 1347.5 1351.9 7344.7 7424.2 7627.7 7637.0 7650.9 1136.6 1137.0 1151.8 1153.7 1169.6 5651.8 5666.0 5710.4 5722.3 5730.7 9486.1 9774.2 9909.2 9939.1 10082.2 9646.5 9921.7 9928.2 9946.1 9974.2 7487.7 7712.7 7753.7 7777.0 7783.9 7231.8 7333.6 7346.8 7361.8 7381.6 8741.0 8742.3 8833.2 8989.3 9029.2 8254.3 9010.0 9122.3 9149.2 9165.5 6453.6 6721.8 6919.2 7081.1 7197.2 7418.1 7433.0 7448.8 7469.1 7490.4 6643.3 6799.8 6834.2 6859.9 6969.1 6832.4 6835.6 6878.8 6915.0 6923.0 7079.5 7122.0 7150.8 7159.6 7243.0 6638.8 6651.4 6683.6 6688.6 6697.4 6607.7 6608.8 6655.9 6670.2 6687.6 05:22:18 INFO - PROCESS | 25562 | 05:22:18 INFO - PROCESS | 25562 | [#4] prototype.html Cycles:180 Average:5321.14 Median:6032.47 stddev:1604.88 (26.6%) stddev-sans-first:1565.26 05:22:18 INFO - PROCESS | 25562 | Values: 341.9 343.1 346.2 349.2 352.1 5968.4 5988.6 5994.1 6010.8 6040.0 5950.3 5958.6 5965.0 5971.1 5984.6 4357.1 4447.7 4490.2 4498.6 4532.5 4532.5 4558.4 4574.7 4597.3 4606.7 4558.3 4563.3 4566.4 4567.6 4568.4 4344.8 4435.8 4519.6 4523.7 4558.8 3987.2 3997.0 3998.1 4001.4 4005.7 5662.3 5685.4 5773.7 5776.6 5781.9 5344.3 5345.4 5348.5 5359.2 5365.0 6289.9 6312.0 6317.0 6318.8 6320.1 4372.1 4434.6 4464.6 4466.3 4468.6 6620.5 6664.3 6668.7 6686.5 6701.5 4584.5 4590.6 4592.1 4592.1 4593.0 4645.8 4646.8 4648.4 4649.2 4652.2 5319.7 5322.4 5324.2 5326.6 5331.3 6187.3 6360.0 6363.5 6368.3 6370.2 1577.4 1593.5 1603.7 1605.4 1606.3 1002.9 1048.9 1069.4 1089.2 1107.1 6027.9 6037.0 6050.2 6125.8 6142.4 6496.9 6520.0 6521.8 6522.4 6527.6 6084.7 6157.2 6159.9 6172.8 6172.9 3492.2 3529.9 3530.1 3534.6 3534.8 6582.7 6721.2 6731.5 6743.2 6747.5 6639.4 6651.9 6657.9 6659.8 6669.3 6704.4 6711.0 6713.8 6714.3 6716.7 6489.3 6492.5 6495.4 6507.1 6517.3 6369.9 6411.6 6419.7 6422.2 6570.6 6840.6 6864.1 6865.9 6866.1 6872.5 4469.1 4507.2 4508.8 4512.9 4521.3 6602.6 6626.5 6630.5 6631.9 6641.0 6373.8 6458.8 6464.0 6464.5 6481.8 6363.4 6417.7 6423.7 6423.7 6425.6 6256.9 6280.7 6292.9 6295.0 6309.6 6435.6 6490.8 6508.1 6513.1 6516.6 6000.4 6096.2 6289.4 6289.5 6295.7 05:22:18 INFO - PROCESS | 25562 | 05:22:18 INFO - PROCESS | 25562 | [#5] yui.html Cycles:180 Average:14777.62 Median:24637.55 stddev:16808.16 (68.2%) stddev-sans-first:16822.36 05:22:18 INFO - PROCESS | 25562 | Values: 762.4 820.7 830.0 855.9 868.7 13372.7 13437.6 13512.7 13579.9 13583.9 13047.9 13482.6 13555.9 13583.6 13589.3 678.7 686.8 824.1 837.9 841.6 848.5 850.9 851.7 851.9 852.7 892.6 895.3 896.5 897.0 897.1 716.7 875.4 888.0 888.0 888.8 647.5 648.8 648.8 649.7 650.0 13308.7 13329.0 13341.7 13354.3 13387.4 13889.9 14342.9 14378.5 14424.6 14562.1 11318.9 11488.7 11488.8 12379.9 12702.0 3860.6 3868.7 3884.5 3920.3 3953.7 51595.5 52042.0 52114.0 52341.7 52362.5 10909.1 11135.6 11223.3 11370.8 11970.0 20028.5 20190.2 20203.9 20501.7 20554.0 8549.3 8784.9 8836.3 8877.9 9062.3 4811.6 4928.3 4978.8 5018.8 5031.6 3208.5 3245.7 3248.8 3250.9 3271.0 610.7 625.2 626.6 629.8 654.1 741.7 778.9 786.1 787.5 803.7 9096.4 9386.6 9695.8 9865.4 9865.6 745.3 751.3 755.1 760.9 769.4 4230.8 4264.4 4392.7 4399.1 4461.3 56835.7 58729.0 60492.2 60856.0 61474.7 53152.0 54035.7 55442.4 55649.7 55913.4 44813.8 46421.5 46483.8 48352.0 51259.7 9824.3 9865.6 9939.5 9981.5 10029.9 35635.8 36941.8 37557.6 37793.0 38079.8 44822.3 45261.3 49420.3 49448.3 49573.5 11836.2 11900.5 11916.9 12075.6 12186.1 11162.2 13231.9 13575.5 14151.4 14266.4 12237.4 12575.8 12621.6 13040.9 13155.9 11922.3 12058.9 12144.1 12199.0 12204.9 11574.8 11773.5 12204.3 12208.1 12557.1 10224.8 10621.4 10656.7 10667.1 11001.8 10144.7 10336.6 10345.1 10390.2 10409.1 05:22:18 INFO - PROCESS | 25562 | -------- Summary: end -------- 05:22:18 INFO - PROCESS | 25562 | 05:22:19 INFO - TEST-INFO | 25562: exit 0 05:22:19 INFO - TEST-OK | dromaeo_css | took 1112310ms 05:22:19 INFO - TEST-START | kraken 05:22:19 INFO - operating with platform_type : linux_ 05:22:19 INFO - Initialising browser for kraken test... 05:22:19 INFO - TEST-INFO | started process 25744 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpU_xZA_/profile http://localhost:55389/getInfo.html) 05:22:24 INFO - PROCESS | 25744 | __metrics Screen width/height:1600/1200 05:22:24 INFO - PROCESS | 25744 | colorDepth:24 05:22:24 INFO - PROCESS | 25744 | Browser inner width/height: 1024/697 05:22:24 INFO - PROCESS | 25744 | __metrics 05:22:25 ERROR - PROCESS | 25744 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:22:26 INFO - TEST-INFO | 25744: exit 0 05:22:26 INFO - Browser initialized. 05:22:26 INFO - Running cycle 1/1 for kraken test... 05:22:26 INFO - TEST-INFO | started process 25825 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpU_xZA_/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:22:38 INFO - PROCESS | 25825 | RSS: Main: 155762688 05:22:38 INFO - PROCESS | 25825 | 05:22:40 INFO - PROCESS | 25825 | Cycle 1(1): loaded http://localhost:55389/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55389/tests/kraken/driver.html?testName=audio-beat-detection) 05:22:41 INFO - PROCESS | 25825 | RSS: Main: 197152768 05:22:41 INFO - PROCESS | 25825 | 05:22:44 INFO - PROCESS | 25825 | Cycle 1(1): loaded http://localhost:55389/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55389/tests/kraken/driver.html?testName=audio-dft) 05:22:44 INFO - PROCESS | 25825 | RSS: Main: 187363328 05:22:44 INFO - PROCESS | 25825 | 05:22:47 INFO - PROCESS | 25825 | Cycle 1(1): loaded http://localhost:55389/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55389/tests/kraken/driver.html?testName=audio-fft) 05:22:48 INFO - PROCESS | 25825 | RSS: Main: 173228032 05:22:48 INFO - PROCESS | 25825 | 05:22:50 INFO - PROCESS | 25825 | Cycle 1(1): loaded http://localhost:55389/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55389/tests/kraken/driver.html?testName=audio-oscillator) 05:22:50 INFO - PROCESS | 25825 | RSS: Main: 173273088 05:22:50 INFO - PROCESS | 25825 | 05:22:53 INFO - PROCESS | 25825 | Cycle 1(1): loaded http://localhost:55389/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55389/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:22:53 INFO - PROCESS | 25825 | RSS: Main: 174899200 05:22:53 INFO - PROCESS | 25825 | 05:22:56 INFO - PROCESS | 25825 | Cycle 1(1): loaded http://localhost:55389/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55389/tests/kraken/driver.html?testName=imaging-darkroom) 05:22:57 INFO - PROCESS | 25825 | RSS: Main: 175255552 05:22:57 INFO - PROCESS | 25825 | 05:23:00 INFO - PROCESS | 25825 | Cycle 1(1): loaded http://localhost:55389/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55389/tests/kraken/driver.html?testName=imaging-desaturate) 05:23:01 INFO - PROCESS | 25825 | RSS: Main: 175738880 05:23:01 INFO - PROCESS | 25825 | 05:23:04 INFO - PROCESS | 25825 | Cycle 1(1): loaded http://localhost:55389/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55389/tests/kraken/driver.html?testName=json-parse-financial) 05:23:04 INFO - PROCESS | 25825 | RSS: Main: 176562176 05:23:04 INFO - PROCESS | 25825 | 05:23:06 INFO - PROCESS | 25825 | Cycle 1(1): loaded http://localhost:55389/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55389/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:23:06 INFO - PROCESS | 25825 | RSS: Main: 188690432 05:23:06 INFO - PROCESS | 25825 | 05:23:08 INFO - PROCESS | 25825 | Cycle 1(1): loaded http://localhost:55389/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55389/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:23:09 INFO - PROCESS | 25825 | RSS: Main: 186994688 05:23:09 INFO - PROCESS | 25825 | 05:23:11 INFO - PROCESS | 25825 | Cycle 1(1): loaded http://localhost:55389/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55389/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:23:11 INFO - PROCESS | 25825 | RSS: Main: 197431296 05:23:11 INFO - PROCESS | 25825 | 05:23:13 INFO - PROCESS | 25825 | Cycle 1(1): loaded http://localhost:55389/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55389/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:23:14 INFO - PROCESS | 25825 | RSS: Main: 203911168 05:23:14 INFO - PROCESS | 25825 | 05:23:17 INFO - PROCESS | 25825 | Cycle 1(1): loaded http://localhost:55389/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55389/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:23:17 INFO - PROCESS | 25825 | RSS: Main: 201441280 05:23:17 INFO - PROCESS | 25825 | 05:23:19 INFO - PROCESS | 25825 | Cycle 1(1): loaded http://localhost:55389/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55389/tests/kraken/driver.html?testName=ai-astar) 05:23:19 INFO - PROCESS | 25825 | RSS: Main: 261345280 05:23:19 INFO - PROCESS | 25825 | 05:23:19 INFO - PROCESS | 25825 | __start_tp_report 05:23:19 INFO - PROCESS | 25825 | _x_x_mozilla_page_load 05:23:19 INFO - PROCESS | 25825 | _x_x_mozilla_page_load_details 05:23:19 INFO - PROCESS | 25825 | |i|pagename|runs| 05:23:19 INFO - PROCESS | 25825 | |0;ai-astar;112;111;105;109;111;112;98;110;109;111 05:23:19 INFO - PROCESS | 25825 | |1;audio-beat-detection;158;132;155;171;141;159;149;127;169;124 05:23:19 INFO - PROCESS | 25825 | |2;audio-dft;161;161;164;161;161;162;159;163;161;160 05:23:19 INFO - PROCESS | 25825 | |3;audio-fft;75;72;96;96;73;75;72;119;97;71 05:23:19 INFO - PROCESS | 25825 | |4;audio-oscillator;92;92;145;93;93;93;143;93;93;140 05:23:19 INFO - PROCESS | 25825 | |5;imaging-gaussian-blur;117;117;116;116;117;116;117;117;117;117 05:23:19 INFO - PROCESS | 25825 | |6;imaging-darkroom;145;146;145;147;145;146;144;144;146;146 05:23:19 INFO - PROCESS | 25825 | |7;imaging-desaturate;96;95;96;95;95;95;95;95;95;95 05:23:19 INFO - PROCESS | 25825 | |8;json-parse-financial;56;57;56;56;56;56;55;68;62;54 05:23:19 INFO - PROCESS | 25825 | |9;json-stringify-tinderbox;60;61;59;60;61;60;59;61;60;60 05:23:19 INFO - PROCESS | 25825 | |10;stanford-crypto-aes;79;79;78;79;86;77;77;78;77;78 05:23:19 INFO - PROCESS | 25825 | |11;stanford-crypto-ccm;115;110;115;111;117;120;107;108;114;109 05:23:19 INFO - PROCESS | 25825 | |12;stanford-crypto-pbkdf2;148;143;145;140;141;131;145;141;139;152 05:23:19 INFO - PROCESS | 25825 | |13;stanford-crypto-sha256-iterative;62;62;67;64;63;64;64;64;63;62 05:23:19 INFO - PROCESS | 25825 | __end_tp_report 05:23:19 INFO - PROCESS | 25825 | __start_cc_report 05:23:19 INFO - PROCESS | 25825 | _x_x_mozilla_cycle_collect,1053 05:23:19 INFO - PROCESS | 25825 | __end_cc_report 05:23:19 INFO - PROCESS | 25825 | __startTimestamp1458649399526__endTimestamp 05:23:19 INFO - PROCESS | 25825 | 05:23:19 INFO - PROCESS | 25825 | ------- Summary: start ------- 05:23:19 INFO - PROCESS | 25825 | Number of tests: 14 05:23:19 INFO - PROCESS | 25825 | 05:23:19 INFO - PROCESS | 25825 | [#0] ai-astar Cycles:10 Average:108.80 Median:111.00 stddev:4.32 (3.9%) stddev-sans-first:4.42 05:23:19 INFO - PROCESS | 25825 | Values: 112.0 111.0 105.0 109.0 111.0 112.0 98.0 110.0 109.0 111.0 05:23:19 INFO - PROCESS | 25825 | 05:23:19 INFO - PROCESS | 25825 | [#1] audio-beat-detection Cycles:10 Average:148.50 Median:156.50 stddev:16.87 (10.8%) stddev-sans-first:17.54 05:23:19 INFO - PROCESS | 25825 | Values: 158.0 132.0 155.0 171.0 141.0 159.0 149.0 127.0 169.0 124.0 05:23:19 INFO - PROCESS | 25825 | 05:23:19 INFO - PROCESS | 25825 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:1.42 (0.9%) stddev-sans-first:1.50 05:23:19 INFO - PROCESS | 25825 | Values: 161.0 161.0 164.0 161.0 161.0 162.0 159.0 163.0 161.0 160.0 05:23:19 INFO - PROCESS | 25825 | 05:23:19 INFO - PROCESS | 25825 | [#3] audio-fft Cycles:10 Average:84.60 Median:75.00 stddev:16.39 (21.9%) stddev-sans-first:17.01 05:23:19 INFO - PROCESS | 25825 | Values: 75.0 72.0 96.0 96.0 73.0 75.0 72.0 119.0 97.0 71.0 05:23:19 INFO - PROCESS | 25825 | 05:23:19 INFO - PROCESS | 25825 | [#4] audio-oscillator Cycles:10 Average:107.70 Median:93.00 stddev:24.16 (26.0%) stddev-sans-first:24.95 05:23:19 INFO - PROCESS | 25825 | Values: 92.0 92.0 145.0 93.0 93.0 93.0 143.0 93.0 93.0 140.0 05:23:19 INFO - PROCESS | 25825 | 05:23:19 INFO - PROCESS | 25825 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 05:23:19 INFO - PROCESS | 25825 | Values: 117.0 117.0 116.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 05:23:19 INFO - PROCESS | 25825 | 05:23:19 INFO - PROCESS | 25825 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:146.00 stddev:0.97 (0.7%) stddev-sans-first:1.01 05:23:19 INFO - PROCESS | 25825 | Values: 145.0 146.0 145.0 147.0 145.0 146.0 144.0 144.0 146.0 146.0 05:23:19 INFO - PROCESS | 25825 | 05:23:19 INFO - PROCESS | 25825 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 05:23:19 INFO - PROCESS | 25825 | Values: 96.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 05:23:19 INFO - PROCESS | 25825 | 05:23:19 INFO - PROCESS | 25825 | [#8] json-parse-financial Cycles:10 Average:57.60 Median:56.00 stddev:4.22 (7.5%) stddev-sans-first:4.44 05:23:19 INFO - PROCESS | 25825 | Values: 56.0 57.0 56.0 56.0 56.0 56.0 55.0 68.0 62.0 54.0 05:23:19 INFO - PROCESS | 25825 | 05:23:19 INFO - PROCESS | 25825 | [#9] json-stringify-tinderbox Cycles:10 Average:60.10 Median:60.00 stddev:0.74 (1.2%) stddev-sans-first:0.78 05:23:19 INFO - PROCESS | 25825 | Values: 60.0 61.0 59.0 60.0 61.0 60.0 59.0 61.0 60.0 60.0 05:23:19 INFO - PROCESS | 25825 | 05:23:19 INFO - PROCESS | 25825 | [#10] stanford-crypto-aes Cycles:10 Average:78.80 Median:78.50 stddev:2.66 (3.4%) stddev-sans-first:2.82 05:23:19 INFO - PROCESS | 25825 | Values: 79.0 79.0 78.0 79.0 86.0 77.0 77.0 78.0 77.0 78.0 05:23:19 INFO - PROCESS | 25825 | 05:23:19 INFO - PROCESS | 25825 | [#11] stanford-crypto-ccm Cycles:10 Average:112.60 Median:114.50 stddev:4.25 (3.7%) stddev-sans-first:4.42 05:23:19 INFO - PROCESS | 25825 | Values: 115.0 110.0 115.0 111.0 117.0 120.0 107.0 108.0 114.0 109.0 05:23:19 INFO - PROCESS | 25825 | 05:23:19 INFO - PROCESS | 25825 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.50 Median:144.00 stddev:5.66 (3.9%) stddev-sans-first:5.64 05:23:19 INFO - PROCESS | 25825 | Values: 148.0 143.0 145.0 140.0 141.0 131.0 145.0 141.0 139.0 152.0 05:23:19 INFO - PROCESS | 25825 | 05:23:19 INFO - PROCESS | 25825 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:64.00 stddev:1.51 (2.4%) stddev-sans-first:1.50 05:23:19 INFO - PROCESS | 25825 | Values: 62.0 62.0 67.0 64.0 63.0 64.0 64.0 64.0 63.0 62.0 05:23:19 INFO - PROCESS | 25825 | -------- Summary: end -------- 05:23:19 INFO - PROCESS | 25825 | 05:23:20 INFO - TEST-INFO | 25825: exit 0 05:23:20 INFO - TEST-OK | kraken | took 60729ms 05:23:20 INFO - SUITE-END | took 1173s 05:23:20 INFO - Completed test suite (00:19:33) 05:23:20 INFO - javascript benchmark 05:23:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3066.4633689104407, 3079.9230019249503, 3119.3917186148697, 3122.67211942746, 3157.905262842114, 5184.481551844814, 5251.054810134175, 5257.7108259045735, 5285.603579731516, 5297.284866543016, 5288.550473209782, 5292.947070529293, 5293.232481290211, 5334.5999050071305, 5350.892982140354, 4744.312074749159, 4746.0, 4753.310769938357, 4761.880952976168, 4936.35827342445, 4865.051314993578, 4877.658563900528, 4889.7066176029375, 4921.064997650453, 4947.925781113287, 4719.952800472003, 4740.549647783472, 4789.568938795525, 4830.686005409672, 4843.975780121112, 4751.40607424072, 4763.737994410306, 4769.308450274691, 4775.0, 4807.399075115611, 4666.32338310943, 4722.362481065046, 4725.978506563031, 4751.738654374008, 4805.927911081337, 5113.437521872591, 5167.405748338914, 5170.922436163461, 5177.844664660066, 5199.948000520022, 5569.777208911639, 5570.6657600543695, 5573.665580065209, 5575.69333686647, 5592.5246354059955, 5569.582281328876, 5580.86047848803, 5581.776728930838, 5585.05054140793, 5613.10190369543, 5220.504052115043, 5250.317458730379, 5250.343707036659, 5255.76349064293, 5309.601779866487, 5783.190353350535, 5788.160716696056, 5800.0, 5801.53587712982, 5811.476967072984, 5338.679679219259, 5448.210009548593, 5517.834464966058, 5528.0, 5533.723313834292, 5592.972035139798, 5596.748146333425, 5598.300212473441, 5605.439456054443, 5624.240727501817, 5570.248016517799, 5588.21764952907, 5588.776448941997, 5588.776448941997, 5602.38373778884, 5431.321084864392, 5549.19536667181, 5566.165075238747, 5684.715764211773, 5721.399253078367, 4113.074558224375, 4119.0526178979, 4119.340905455113, 4123.711340206157, 4159.708820382604, 3714.2200137971327, 3715.6841668458483, 3716.7769933804057, 3727.8508859645854, 3740.0649837540614, 5255.842324730188, 5316.229146773696, 5355.705436201047, 5396.514313711707, 5401.459854014567, 5629.802956896489, 5638.4925356718095, 5644.294463192101, 5662.37713851476, 5678.261825962599, 5251.36983561975, 5354.491323324278, 5368.2752828367675, 5368.436314187033, 5412.134058550613, 4799.688020278671, 4810.302506136591, 4821.686590371684, 4864.270359446041, 4867.050925069578, 5744.569157313218, 5750.712464376765, 5755.85610359736, 5756.251687280626, 5757.078867381283, 5548.278723765885, 5560.7219639018695, 5564.415736347625, 5567.47109024642, 5619.8314050579365, 5856.707164641665, 5861.648301101947, 5886.52907767369, 5893.174955506147, 5940.346561878104, 5576.5817563683695, 5583.860403489945, 5588.077967135378, 5589.9938011156755, 5590.161475778666, 5486.753096110605, 5672.829815105553, 5674.233978412862, 5675.4892059713175, 5775.595708300379, 5492.176173573996, 5495.477929596682, 5497.202905578749, 5498.780048798003, 5531.059719847555, 5456.781728730806, 5461.262729531462, 5462.808801691922, 5464.316960379952, 5512.173174023928, 5133.0, 5376.973115134399, 5390.137577987503, 5459.69971651563, 5489.64317319373, 5536.695481748542, 5546.306711661043, 5549.056660367666, 5551.7779288828, 5564.443555644403, 5419.783208671609, 5432.158015507603, 5432.239486471976, 5434.945650543602, 5445.809396671098], "unit": "score", "name": "dojo.html", "value": 5174.464916069301}, {"lowerIsBetter": false, "replicates": [557.3089369182213, 562.4459906991614, 572.2303501790091, 584.6141546579257, 595.7914729844553, 29907.252318692015, 37968.62031379689, 38352.0, 38419.231615367746, 38423.231535369276, 41077.58922410775, 41416.17167656645, 41543.58456415442, 41625.0, 41689.37465938006, 7928.326092282134, 8631.913680863174, 8798.780030499225, 8802.119788021211, 8811.030786613468, 8017.278444939954, 10480.842787358195, 10729.892701073006, 10746.140308775279, 10747.0, 10418.583256669725, 10514.316569423001, 10530.104941080017, 10539.051485366315, 10546.367217966908, 10320.071193592537, 10320.380777153357, 10380.584776608926, 10392.272540922138, 10400.271980961335, 10256.07695307426, 10303.690889273334, 10369.481525923673, 10374.533146008447, 10385.740356491073, 41633.167336653096, 42087.789561052305, 42196.57803421957, 42231.577684223375, 42241.0, 3380.915477113067, 3458.913527161816, 3498.860045598173, 3517.8944631661093, 3893.5133108361456, 31826.840865795522, 32060.19849503781, 32384.352312953844, 32494.83752581222, 32553.186170345693, 4178.958210417887, 4259.616634502879, 4273.764942928137, 4297.67767417445, 4334.436523251957, 326540.0, 327048.0, 327560.0, 327662.0, 328702.9999999976, 47613.047739045025, 47767.283490747664, 47844.521554784704, 47847.65066445385, 61366.0, 45898.311525327146, 46215.0, 46227.0, 46396.30405543919, 46481.30278045832, 15617.609559761097, 15713.842861571238, 15769.132697701507, 15769.763453548207, 15771.369145234292, 12331.630051098482, 12370.257784532956, 12402.13185077036, 12408.441620127116, 12556.686082848002, 16073.115978621288, 16112.75830862538, 16294.42969496062, 16305.836941630669, 16308.266128024268, 6113.205283313141, 6267.310595834455, 6299.433051025429, 6316.778912738124, 6338.7464501420345, 1031.3811712972306, 1046.3146638951498, 1053.073295499955, 1077.42357838556, 1143.9599614013468, 31840.840795795873, 32603.347933041205, 32668.673313267038, 32767.344653106804, 32989.67010329914, 982.1553464020936, 1069.4866464097122, 1094.768385566238, 1122.859642544682, 1131.4060118437885, 14511.346989385504, 15059.247037648074, 15286.0, 15335.386584536494, 17402.303907843798, 467932.0, 473673.0, 474060.0, 474555.0, 475231.0, 59513.70243148757, 59529.40470595239, 59545.106823397684, 59627.40372596305, 59667.0, 1300.4148133340034, 1405.669667628086, 1405.845357010728, 1422.7723564229673, 1455.7743549749805, 28249.293767655974, 29122.98069567555, 29475.557866632447, 30029.24926876758, 30381.69618303877, 42056.369154462096, 42430.57569424266, 42482.57517424786, 42545.0, 42601.786991064844, 290277.0, 297653.0, 297914.0, 297964.0, 298323.0, 30566.388672226876, 34858.302833943686, 34979.0, 35199.296014080086, 35712.642873570934, 41133.0, 42028.36957445702, 49381.25928111153, 50057.0, 50478.49521504738, 36385.0, 36648.63351366559, 36722.63277367192, 36982.0, 37089.44365834461, 35609.0, 35740.0, 35869.282614347045, 35984.28031439304, 36024.81987590045, 36950.6304936958, 37204.0, 37635.43546846745, 37969.810150949066, 38031.61968380392, 34622.480662790585, 36570.0, 37325.25349493049, 37399.25201496009, 38164.618353816106, 26137.954481820514, 26317.21048368552, 26464.470710586065, 26501.60247596249, 28349.716502834708], "unit": "score", "name": "ext.html", "value": 19264.468982860762}, {"lowerIsBetter": false, "replicates": [369.7485709717391, 373.3298728781837, 376.69864108713034, 376.9415740560214, 381.36883457877224, 18465.44603661889, 18638.161282742276, 19315.323963661238, 19402.611947761055, 19410.611787764235, 17992.280308787635, 18359.44921652349, 18955.90522047388, 19021.334253301102, 19101.42695719127, 5506.834794956148, 5640.915386269188, 5661.631993920402, 5665.490105890469, 5675.801346952858, 4136.193442278757, 5580.469855363734, 5958.195643588104, 6229.314775374728, 6248.562600617958, 6133.509319254449, 6169.845753856144, 6183.227096612924, 6199.194104766374, 6202.317745048041, 5946.791862284799, 6124.203853499062, 6129.478994285491, 6132.049532322497, 6132.049532322497, 3783.810809459516, 5284.4187139414635, 5367.329083864517, 5449.700266485342, 5463.726813659301, 22102.88948555263, 22575.548489030127, 22653.32040038785, 22773.0, 22911.770882291297, 2318.2813327868416, 2344.953100937989, 2580.729023452548, 3003.354278830062, 3051.633803943541, 13878.583642490741, 14117.294135293194, 14249.857501424956, 14444.205568693718, 14580.635484112981, 1919.2131226197332, 1977.4561995451222, 2008.1164287713505, 2014.3453377652322, 2016.596680663873, 66849.3315066848, 68987.0, 69023.65488172577, 69146.30853691448, 69591.3040869595, 10471.3193642413, 10530.104581175461, 10603.310784798963, 10822.621208257673, 10952.233343665866, 13980.650483737987, 14010.229437380838, 14093.15441073539, 14103.153810771386, 14107.647308817157, 8051.315638170821, 8309.626066827008, 8382.07797142314, 8504.404691671523, 8523.95738021306, 8326.45878017927, 8392.748217553482, 8457.746267611981, 8530.189631984951, 8534.573271336409, 6578.473722102221, 6674.132362792806, 6690.431313338323, 6694.966525167343, 6706.094677218513, 1728.8357606027407, 1753.3687872365938, 1763.4709587123812, 1767.5050985724017, 1850.7316439116253, 987.6790043235977, 1032.396048311731, 1042.593388578455, 1063.8989296016866, 1114.9275297105662, 18125.728114078298, 18427.81572184288, 18699.532511687044, 18912.90543547301, 19017.144228509474, 1026.1277913773383, 1063.0, 1075.8224892892742, 1095.7151140703315, 1118.3010618363523, 10493.0, 10730.624428145133, 10732.0, 10808.0, 10921.0, 496781.0, 512385.0, 522842.0, 523012.0, 526637.934482624, 64080.0, 67583.0, 67749.0, 68121.31878681149, 68426.65786671035, 1088.2110469909253, 1095.6822521468684, 1096.2381145104237, 1096.780643871229, 1117.2793548161553, 16208.270627822012, 16237.67524649524, 16249.26878290456, 16506.504804855875, 16529.66940661156, 33656.49515257224, 34552.13619659529, 35164.296714066084, 35204.823975879954, 35276.11809704778, 44520.554794451644, 45908.0, 46208.07583848372, 46254.537454625024, 46783.76608116938, 8039.638216280398, 8040.87938680932, 8110.472819266729, 8150.510969341858, 8158.265756081981, 12424.75150497003, 12479.126461147996, 12603.369831508204, 12652.17760845542, 12714.173578717353, 11155.382469542034, 11381.374024428736, 11382.487788049391, 11527.596534121265, 11701.06391488696, 11103.38931358783, 11196.328220306808, 11222.326660400402, 11333.603323883954, 11510.13673974472, 11266.718332041764, 11524.59663911759, 11573.652790415965, 11682.649520514398, 11700.765984680429, 7610.961945190239, 7911.960440197992, 8002.399820013406, 8056.919430805617, 8242.629081691219, 10750.354978701303, 10790.460476976277, 11092.667219983414, 11160.944195278971, 11232.494537745657], "unit": "score", "name": "jquery.html", "value": 9114.888512002633}, {"lowerIsBetter": false, "replicates": [1335.3959778432047, 1466.0, 1491.6420059185791, 1680.722680757675, 1853.8424233940113, 7577.696892124315, 7792.0, 7813.765587032398, 7817.022872140989, 7845.686172553105, 7791.571463569501, 7923.6830526779, 7930.484518506293, 7935.722249721261, 7952.403569732264, 1998.8400927925804, 2264.705588273522, 2293.747687754346, 2295.908163673451, 2345.8240631952585, 2354.9175778847743, 2366.8461549999283, 2367.6330168823774, 2367.7750613691674, 2369.3484291819714, 2229.1863469833474, 2321.6401457773986, 2322.2336628912503, 2323.6514522821544, 2327.3250757280452, 2275.613145765224, 2301.723793144825, 2356.0, 2357.6463530470483, 2359.905603775847, 2319.8724070176136, 2326.348622385735, 2335.544568809083, 2343.6836027136287, 2358.9738463768317, 7961.283484486424, 7985.960070199611, 8004.599770011476, 8011.399145064143, 8014.959925200336, 4939.259111133323, 5017.698938063728, 5056.797728090872, 5057.519535644108, 5058.064258112261, 3360.8487618057247, 3448.3448144852396, 3507.91230219244, 3517.314123745871, 3529.4882242074755, 1207.6618546806908, 1219.8780121987818, 1223.3883058470765, 1241.2924632959216, 1281.980770288437, 11056.336619802838, 11185.608503702413, 11207.887921120766, 11212.383318917457, 11242.213045086848, 4399.5380485049245, 4486.1252055849445, 4542.046170304207, 4553.362529245908, 4563.520830312769, 9502.0, 9532.761680958032, 9535.52322383878, 9553.808923821485, 9593.040695930351, 4475.462944446687, 5003.449620541737, 5036.0, 5044.545990860766, 5045.5459008689395, 4478.888027799331, 4481.170983368087, 4580.1755683976535, 4585.358049873021, 4585.885352866205, 3851.2297540491454, 3908.218356328746, 3923.7841918694176, 3927.842886284574, 3946.625070618287, 1242.4595301044076, 1261.4954018392716, 1264.4626033935724, 1267.0623738433492, 1276.3809552367095, 1328.7807511760645, 1338.9263590502617, 1344.8386193656825, 1347.5351003903834, 1351.8783309502192, 7344.706211751577, 7424.183339832614, 7627.733029343946, 7637.0, 7650.923490765133, 1136.5851464215666, 1136.9658910232706, 1151.758130792543, 1153.7058050197145, 1169.5672601137633, 5651.802186923438, 5665.9716701417055, 5710.371859095496, 5722.313322401338, 5730.656160630376, 9486.098820612031, 9774.218062555121, 9909.20726341891, 9939.055789699967, 10082.193424526167, 9646.469444180497, 9921.702348929544, 9928.205743540499, 9946.055124763136, 9974.152197063331, 7487.737929172453, 7712.691492340356, 7753.7286194984035, 7777.0, 7783.922160778433, 7231.819204519718, 7333.596652184181, 7346.77959661211, 7361.779146625609, 7381.630918454163, 8741.0, 8742.300615950835, 8833.205011548991, 8989.28085753125, 9029.187373136449, 8254.339652827639, 9009.954950225207, 9122.315826313186, 9149.176574108362, 9165.495897725688, 6453.580517266362, 6721.764738234334, 6919.238883722685, 7081.114860642419, 7197.244289349543, 7418.109826820816, 7432.962835185789, 7448.813779655336, 7469.141048779243, 7490.4007679386605, 6643.30245324234, 6799.830004249933, 6834.179898412222, 6859.9314006859295, 6969.128858892638, 6832.419244364086, 6835.555688880207, 6878.759243426456, 6915.0, 6923.0, 7079.539829911039, 7122.0, 7150.785476435715, 7159.57042577447, 7242.96378518104, 6638.800835974928, 6651.401373876374, 6683.63240021784, 6688.565243259172, 6697.430718388991, 6607.702653380513, 6608.768693095911, 6655.900161497679, 6670.199576050905, 6687.63218022994], "unit": "score", "name": "mootools.html", "value": 4674.431947388526}, {"lowerIsBetter": false, "replicates": [341.9144217110674, 343.0771225403664, 346.20373141773916, 349.19510528232416, 352.0529774905506, 5968.432998865112, 5988.640681559104, 5994.0709190075495, 6010.789622363218, 6040.0, 5950.315713692927, 5958.642481451116, 5965.015772397549, 5971.1043343498495, 5984.581079324438, 4357.063231405239, 4447.733136011833, 4490.169318676056, 4498.617617502517, 4532.4787649420405, 4532.52408497108, 4558.38461807655, 4574.702644328125, 4597.310403439494, 4606.654500912428, 4558.316252562109, 4563.338315944186, 4566.356111799766, 4567.58891699747, 4568.428946381702, 4344.847930322455, 4435.778211089465, 4519.638428925678, 4523.683342166049, 4558.794854231551, 3987.2424239394713, 3997.040710229524, 3998.080441498472, 4001.379786133154, 4005.719599628027, 5662.263905692274, 5685.431456854281, 5773.711314434261, 5776.624519406225, 5781.942180578182, 5344.305240318772, 5345.412004679482, 5348.465153484621, 5359.196120581905, 5365.007473617355, 6289.905651415233, 6312.0, 6316.96841515794, 6318.810435686937, 6320.115183874262, 4372.081862808814, 4434.600885920283, 4464.575865292792, 4466.307722303049, 4468.642508599337, 6620.503462240303, 6664.266930637626, 6668.666566671647, 6686.531942764009, 6701.530892837503, 4584.518625544337, 4590.5638964299005, 4592.104539614743, 4592.10453961481, 4593.0, 4645.837395691135, 4646.767661616906, 4648.372469716613, 4649.163150632919, 4652.162610730101, 5319.654222475527, 5322.3879253885525, 5324.227986941872, 5326.6005049621435, 5331.306930099062, 6187.319394866561, 6360.0, 6363.522735794834, 6368.331325210786, 6370.235571731329, 1577.4163559483065, 1593.5219434169935, 1603.711331960235, 1605.3739041773717, 1606.3173151410604, 1002.9197664186994, 1048.8636477257908, 1069.417167643636, 1089.1776708584969, 1107.1198397274186, 6027.939720602825, 6037.0, 6050.152978583002, 6125.785597504066, 6142.447179753844, 6496.870062598721, 6519.967400162969, 6521.771737989147, 6522.380373864476, 6527.640979746065, 6084.665343406155, 6157.230346206724, 6159.938400616026, 6172.753089876444, 6172.938270617236, 3492.161881148506, 3529.8764543240864, 3530.135116896377, 3534.6111927687934, 3534.8232588370993, 6582.670866456658, 6721.1598550181225, 6731.528792984444, 6743.224529179109, 6747.527673062937, 6639.4024537790865, 6651.866962660816, 6657.933420665731, 6659.833504162435, 6669.2997235289595, 6704.430123439464, 6711.0, 6713.798586042427, 6714.328567143247, 6716.697748601325, 6489.318621544859, 6492.5455218134275, 6495.447886929664, 6507.056476810931, 6517.283098859217, 6369.936300636934, 6411.5832470889245, 6419.679016049272, 6422.197225346832, 6570.605763654196, 6840.623765692736, 6864.141982252218, 6865.931340686529, 6866.073080134118, 6872.484563657646, 4469.128519938711, 4507.233770259129, 4508.774561271857, 4512.932306015478, 4521.276595744665, 6602.636854973022, 6626.53614246998, 6630.502712296694, 6631.867362652816, 6640.966795165993, 6373.776917807854, 6458.806235812933, 6463.967680161569, 6464.450521705708, 6481.805545833632, 6363.3636636336, 6417.71120299597, 6423.678816059271, 6423.743050277936, 6425.550211485338, 6256.874862502816, 6280.685965701788, 6292.9370706294185, 6294.968525157345, 6309.621422714652, 6435.581687190318, 6490.772822951174, 6508.056331831953, 6513.088167656437, 6516.641584712696, 6000.369961154191, 6096.177016102769, 6289.40250676185, 6289.465395441256, 6295.748170073146], "unit": "score", "name": "prototype.html", "value": 4800.211419812488}, {"lowerIsBetter": false, "replicates": [762.3786613909665, 820.7414664380719, 829.9626516806743, 855.8972923249211, 868.7002983970532, 13372.665683357922, 13437.596872093853, 13512.662183445394, 13579.864201357983, 13583.93208033961, 13047.869521304785, 13482.595522134352, 13555.864441355583, 13583.592492225249, 13589.252591107484, 678.7149397253165, 686.7802303262957, 824.0893812337371, 837.8826964225013, 841.5834162089774, 848.5375470368664, 850.8936382952131, 851.6721062390963, 851.8509260879322, 852.7100785732849, 892.6117139044504, 895.3150839607705, 896.4666023715911, 896.9641214351418, 897.1432282170512, 716.6739133694183, 875.3784812782932, 888.0054339140172, 888.0453512474052, 888.7778055486128, 647.4981889035988, 648.7696867611977, 648.8410339466814, 649.6881496881523, 649.9967500162469, 13308.733825323536, 13329.0, 13341.733165336736, 13354.26551539665, 13387.397567109503, 13889.861101388959, 14342.856571434257, 14378.496752613713, 14424.639384015378, 14562.053466524749, 11318.886811131866, 11488.712782180428, 11488.827667584992, 12379.938100309531, 12702.0, 3860.613938606145, 3868.6711629511524, 3884.533855937277, 3920.313945059632, 3953.743006704584, 51595.48404515944, 52042.0, 52114.0, 52341.738291308684, 52362.47637523576, 10909.127269818555, 11135.554577816796, 11223.326600404002, 11370.772584548262, 11970.0, 20028.499287517636, 20190.192392304143, 20203.8989805053, 20501.692474612893, 20554.0, 8549.27331176857, 8784.912150878537, 8836.337274704423, 8877.911220887838, 9062.275017998545, 4811.639127065414, 4928.28539861718, 4978.825741099116, 5018.824341148043, 5031.622628302892, 3208.51872219169, 3245.659205783406, 3248.7725859190105, 3250.934981300361, 3270.967290327114, 610.6763415389851, 625.2465778736612, 626.6428135962549, 629.8110566829932, 654.1398061549048, 741.6551303643831, 778.8870613760973, 786.1431040166246, 787.5314188058096, 803.7468197517763, 9096.408733432438, 9386.5776040077, 9695.757606059906, 9865.408075515492, 9865.605375785031, 745.3366503811612, 751.3125490176427, 755.1014292991323, 760.9086909570776, 769.4229328003997, 4230.767307798039, 4264.445622069174, 4392.692511524163, 4399.098184872094, 4461.330800379969, 56835.71582142063, 58729.0, 60492.18523444304, 60856.0, 61474.692626536584, 53152.0, 54035.729821350644, 55442.44557554454, 55649.72175139179, 55913.44086559083, 44813.775931120785, 46421.535784642394, 46483.76758116255, 48352.0, 51259.743701282, 9824.263180261652, 9865.605375784888, 9939.453330066915, 9981.500924953869, 10029.899701003189, 35635.82182089073, 36941.815290924445, 37557.62442375541, 37793.0, 38079.80960095182, 44822.3276650857, 45261.32108018317, 49420.27042460548, 49448.25827612517, 49573.504264958334, 11836.171467997157, 11900.464479098287, 11916.940415298215, 12075.577354792891, 12186.086043546593, 11162.218644694793, 13231.867681323063, 13575.52485662997, 14151.363188656329, 14266.358013889192, 12237.388130593612, 12575.811362829749, 12621.621351359474, 13040.934795325962, 13155.93422032922, 11922.284662920252, 12058.879411206126, 12144.089193310361, 12199.0, 12204.877951220375, 11574.826377604175, 11773.47019384147, 12204.267743935392, 12208.145429819828, 12557.058220633306, 10224.846627300745, 10621.362718236931, 10656.733581660521, 10667.146628269564, 11001.779964400826, 10144.746381340525, 10336.638217662347, 10345.068943795095, 10390.22073344487, 10409.11522520564], "unit": "score", "name": "yui.html", "value": 6816.610207907834}], "name": "dromaeo_css", "value": 7197.170281328674}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 111.0, 105.0, 109.0, 111.0, 112.0, 98.0, 110.0, 109.0, 111.0], "unit": "score", "name": "ai-astar", "value": 108.8}, {"lowerIsBetter": true, "replicates": [158.0, 132.0, 155.0, 171.0, 141.0, 159.0, 149.0, 127.0, 169.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 148.5}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 164.0, 161.0, 161.0, 162.0, 159.0, 163.0, 161.0, 160.0], "unit": "score", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [75.0, 72.0, 96.0, 96.0, 73.0, 75.0, 72.0, 119.0, 97.0, 71.0], "unit": "score", "name": "audio-fft", "value": 84.6}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 145.0, 93.0, 93.0, 93.0, 143.0, 93.0, 93.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 107.7}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 116.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.7}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 145.0, 147.0, 145.0, 146.0, 144.0, 144.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 56.0, 56.0, 56.0, 56.0, 55.0, 68.0, 62.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 57.6}, {"lowerIsBetter": true, "replicates": [60.0, 61.0, 59.0, 60.0, 61.0, 60.0, 59.0, 61.0, 60.0, 60.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 60.1}, {"lowerIsBetter": true, "replicates": [79.0, 79.0, 78.0, 79.0, 86.0, 77.0, 77.0, 78.0, 77.0, 78.0], "unit": "score", "name": "stanford-crypto-aes", "value": 78.8}, {"lowerIsBetter": true, "replicates": [115.0, 110.0, 115.0, 111.0, 117.0, 120.0, 107.0, 108.0, 114.0, 109.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 112.6}, {"lowerIsBetter": true, "replicates": [148.0, 143.0, 145.0, 140.0, 141.0, 131.0, 145.0, 141.0, 139.0, 152.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.5}, {"lowerIsBetter": true, "replicates": [62.0, 62.0, 67.0, 64.0, 63.0, 64.0, 64.0, 64.0, 63.0, 62.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 63.5}], "name": "kraken", "value": 1483.3}]} 05:23:20 INFO - Return code: 0 05:23:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:23:20 ERROR - # TBPL SUCCESS # 05:23:20 INFO - Running post-action listener: _resource_record_post_action 05:23:20 INFO - Running post-run listener: _resource_record_post_run 05:23:21 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 12288; Write bytes: 534327296; Read time: 1048; Write time: 1072892 05:23:21 INFO - install - Wall time: 17s; CPU: 16.0%; Read bytes: 4096; Write bytes: 242679808; Read time: 292; Write time: 540772 05:23:21 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 8192; Write bytes: 291647488; Read time: 756; Write time: 532120 05:23:21 INFO - Running post-run listener: _upload_blobber_files 05:23:21 INFO - Blob upload gear active. 05:23:21 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:23:21 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:23:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 05:23:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 05:23:22 INFO - (blobuploader) - INFO - Open directory for files ... 05:23:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 05:23:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:23:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:23:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:23:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:23:23 INFO - (blobuploader) - INFO - Done attempting. 05:23:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:23:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:23:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:23:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:23:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:23:24 INFO - (blobuploader) - INFO - Done attempting. 05:23:24 INFO - (blobuploader) - INFO - Iteration through files over. 05:23:24 INFO - Return code: 0 05:23:24 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:23:24 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:23:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8662c47d442bf35d7f6552856d2310756736d2faac2a22d1b457aea68e98f5adaaa86a8bf3b95e68a02e333cc31da92b17df9fdfa8df930313495076d2919393", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4dd025cedd6c2bd513437e97222317670a8770f634835991bc993051e2081a690a9a39c0e241678f5f3977b0d74b08b02e8b5fbf26d07919bc943001dbce67e2"} 05:23:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:23:24 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:23:24 INFO - Contents: 05:23:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8662c47d442bf35d7f6552856d2310756736d2faac2a22d1b457aea68e98f5adaaa86a8bf3b95e68a02e333cc31da92b17df9fdfa8df930313495076d2919393", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4dd025cedd6c2bd513437e97222317670a8770f634835991bc993051e2081a690a9a39c0e241678f5f3977b0d74b08b02e8b5fbf26d07919bc943001dbce67e2"} 05:23:24 INFO - Running post-run listener: copy_logs_to_upload_dir 05:23:24 INFO - Copying logs to upload dir... 05:23:24 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 05:23:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.572358 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-03-22 05:23:24.362565) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-22 05:23:24.366145) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1458647649.650103-1832580050 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8662c47d442bf35d7f6552856d2310756736d2faac2a22d1b457aea68e98f5adaaa86a8bf3b95e68a02e333cc31da92b17df9fdfa8df930313495076d2919393", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4dd025cedd6c2bd513437e97222317670a8770f634835991bc993051e2081a690a9a39c0e241678f5f3977b0d74b08b02e8b5fbf26d07919bc943001dbce67e2"} build_url:https://queue.taskcluster.net/v1/task/NNKRAO9lTHSWme4Nzwdgyw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011438 build_url: 'https://queue.taskcluster.net/v1/task/NNKRAO9lTHSWme4Nzwdgyw/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/Fx-Team/sha512/8662c47d442bf35d7f6552856d2310756736d2faac2a22d1b457aea68e98f5adaaa86a8bf3b95e68a02e333cc31da92b17df9fdfa8df930313495076d2919393", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4dd025cedd6c2bd513437e97222317670a8770f634835991bc993051e2081a690a9a39c0e241678f5f3977b0d74b08b02e8b5fbf26d07919bc943001dbce67e2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-22 05:23:24.391733) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 05:23:24.392103) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1458647649.650103-1832580050 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004474 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 05:23:24.477107) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-22 05:23:24.478001) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-22 05:23:24.478674) ========= ========= Total master_lag: 0.31 =========