builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-064 starttime: 1458931585.28 results: success (0) buildid: 20160325083832 builduid: 703c5dbd273e4d7a854b9a0ba50a2520 revision: b2dbee5ca727 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-25 11:46:25.280423) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-25 11:46:25.280974) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-25 11:46:25.281299) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1458929938.980286-947849827 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006510 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-25 11:46:25.305829) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-25 11:46:25.306138) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-25 11:46:25.322750) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 11:46:25.323094) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1458929938.980286-947849827 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004639 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 11:46:25.374980) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-25 11:46:25.375299) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-25 11:46:25.375674) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 11:46:25.375960) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1458929938.980286-947849827 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-25 11:46:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.7M=0s 2016-03-25 11:46:27 (42.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.169874 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 11:46:25.559975) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 11:46:25.560308) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1458929938.980286-947849827 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019199 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 11:46:25.610318) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 11:46:25.610683) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b2dbee5ca727 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev b2dbee5ca727 --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=a12cd81e0ef515edd9e0d800000001bb-1458929938.980286-947849827 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-25 11:46:27,828 Setting DEBUG logging. 2016-03-25 11:46:27,828 attempt 1/10 2016-03-25 11:46:27,828 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b2dbee5ca727?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-25 11:46:28,090 unpacking tar archive at: mozilla-central-b2dbee5ca727/testing/mozharness/ program finished with exit code 0 elapsedTime=0.563561 ========= master_lag: 0.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 11:46:26.260594) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-25 11:46:26.260944) ========= echo b2dbee5ca727 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'b2dbee5ca727'] 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=a12cd81e0ef515edd9e0d800000001bb-1458929938.980286-947849827 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False b2dbee5ca727 program finished with exit code 0 elapsedTime=0.004689 script_repo_revision: 'b2dbee5ca727' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-25 11:46:26.312245) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-25 11:46:26.312613) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-25 11:46:26.326991) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-03-25 11:46:26.327437) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1458929938.980286-947849827 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:46:28 INFO - MultiFileLogger online at 20160325 11:46:28 in /builds/slave/test-pgo 11:46:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 11:46:28 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 11:46:28 INFO - {'append_to_log': False, 11:46:28 INFO - 'base_work_dir': '/builds/slave/test-pgo', 11:46:28 INFO - 'blob_upload_branch': 'Firefox', 11:46:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 11:46:28 INFO - 'branch': 'Firefox', 11:46:28 INFO - 'buildbot_json_path': 'buildprops.json', 11:46:28 INFO - 'config_files': ('talos/linux_config.py',), 11:46:28 INFO - 'default_actions': ('clobber', 11:46:28 INFO - 'read-buildbot-config', 11:46:28 INFO - 'download-and-extract', 11:46:28 INFO - 'populate-webroot', 11:46:28 INFO - 'create-virtualenv', 11:46:28 INFO - 'install', 11:46:28 INFO - 'run-tests'), 11:46:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:46:28 INFO - 'download_minidump_stackwalk': True, 11:46:28 INFO - 'download_symbols': 'ondemand', 11:46:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:46:28 INFO - 'tooltool.py': '/tools/tooltool.py', 11:46:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:46:28 INFO - '/tools/misc-python/virtualenv.py')}, 11:46:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:46:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:46:28 INFO - 'installer_path': 'installer.exe', 11:46:28 INFO - 'log_level': 'info', 11:46:28 INFO - 'log_name': 'talos', 11:46:28 INFO - 'log_to_console': True, 11:46:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:46:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:46:28 INFO - 'opt_config_files': (), 11:46:28 INFO - 'pip_index': False, 11:46:28 INFO - 'sps_profile': False, 11:46:28 INFO - 'sps_profile_interval': 0, 11:46:28 INFO - 'suite': 'dromaeojs', 11:46:28 INFO - 'system_bits': '32', 11:46:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:46:28 INFO - 'title': 'talos-linux64-ix-064', 11:46:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:46:28 INFO - 'use_talos_json': True, 11:46:28 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 11:46:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:46:28 INFO - 'work_dir': 'build'} 11:46:28 INFO - ##### 11:46:28 INFO - ##### Running clobber step. 11:46:28 INFO - ##### 11:46:28 INFO - Running pre-action listener: _resource_record_pre_action 11:46:28 INFO - Running main action method: clobber 11:46:28 INFO - rmtree: /builds/slave/test-pgo/build 11:46:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 11:46:29 INFO - Running post-action listener: _resource_record_post_action 11:46:29 INFO - ##### 11:46:29 INFO - ##### Running read-buildbot-config step. 11:46:29 INFO - ##### 11:46:29 INFO - Running pre-action listener: _resource_record_pre_action 11:46:29 INFO - Running main action method: read_buildbot_config 11:46:29 INFO - Using buildbot properties: 11:46:29 INFO - { 11:46:29 INFO - "project": "", 11:46:29 INFO - "product": "firefox", 11:46:29 INFO - "script_repo_revision": "production", 11:46:29 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 11:46:29 INFO - "repository": "", 11:46:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 11:46:29 INFO - "buildid": "20160325083832", 11:46:29 INFO - "stage_platform": "linux64-pgo", 11:46:29 INFO - "basedir": "/builds/slave/test-pgo", 11:46:29 INFO - "nightly_build": "True", 11:46:29 INFO - "buildnumber": 239, 11:46:29 INFO - "slavename": "talos-linux64-ix-064", 11:46:29 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:46:29 INFO - "platform": "ubuntu64_hw", 11:46:29 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 11:46:29 INFO - "branch": "mozilla-central", 11:46:29 INFO - "repo_path": "mozilla-central", 11:46:29 INFO - "revision": "b2dbee5ca727", 11:46:29 INFO - "pgo_build": "True", 11:46:29 INFO - "builduid": "703c5dbd273e4d7a854b9a0ba50a2520", 11:46:29 INFO - "slavebuilddir": "test" 11:46:29 INFO - } 11:46:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/TywIZsxwQtKWExtABuSh_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 11:46:29 INFO - Running post-action listener: _resource_record_post_action 11:46:29 INFO - ##### 11:46:29 INFO - ##### Running download-and-extract step. 11:46:29 INFO - ##### 11:46:29 INFO - Running pre-action listener: _resource_record_pre_action 11:46:29 INFO - Running main action method: download_and_extract 11:46:29 INFO - mkdir: /builds/slave/test-pgo/build/tests 11:46:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:46:29 INFO - https://queue.taskcluster.net/v1/task/TywIZsxwQtKWExtABuSh_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:46:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TywIZsxwQtKWExtABuSh_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:46:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TywIZsxwQtKWExtABuSh_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:46:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TywIZsxwQtKWExtABuSh_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:46:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TywIZsxwQtKWExtABuSh_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:46:37 INFO - Downloaded 1361 bytes. 11:46:37 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:46:37 INFO - Using the following test package requirements: 11:46:37 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 11:46:37 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:46:37 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:46:37 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:46:37 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:46:37 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:46:37 INFO - u'jsshell-linux-x86_64.zip'], 11:46:37 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:46:37 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:46:37 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 11:46:37 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:46:37 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:46:37 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:46:37 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:46:37 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:46:37 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:46:37 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:46:37 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:46:37 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:46:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:46:37 INFO - https://queue.taskcluster.net/v1/task/TywIZsxwQtKWExtABuSh_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:46:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TywIZsxwQtKWExtABuSh_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:46:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TywIZsxwQtKWExtABuSh_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:46:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TywIZsxwQtKWExtABuSh_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:46:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TywIZsxwQtKWExtABuSh_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:46:39 INFO - Downloaded 23655450 bytes. 11:46:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 11:46:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 11:46:40 INFO - Return code: 0 11:46:40 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:46:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:46:40 INFO - https://queue.taskcluster.net/v1/task/TywIZsxwQtKWExtABuSh_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:46:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TywIZsxwQtKWExtABuSh_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:46:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TywIZsxwQtKWExtABuSh_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:46:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TywIZsxwQtKWExtABuSh_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:46:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TywIZsxwQtKWExtABuSh_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:46:53 INFO - Downloaded 23655450 bytes. 11:46:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 11:46:53 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 11:46:55 INFO - Return code: 0 11:46:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:46:55 INFO - https://queue.taskcluster.net/v1/task/TywIZsxwQtKWExtABuSh_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:46:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TywIZsxwQtKWExtABuSh_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 11:46:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TywIZsxwQtKWExtABuSh_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 11:46:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TywIZsxwQtKWExtABuSh_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 11:46:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TywIZsxwQtKWExtABuSh_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:46:59 INFO - Downloaded 10847531 bytes. 11:46:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 11:46:59 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 11:46:59 INFO - Return code: 0 11:46:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:46:59 INFO - https://queue.taskcluster.net/v1/task/TywIZsxwQtKWExtABuSh_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:46:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TywIZsxwQtKWExtABuSh_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:46:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TywIZsxwQtKWExtABuSh_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:46:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TywIZsxwQtKWExtABuSh_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:46:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TywIZsxwQtKWExtABuSh_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:47:03 INFO - Downloaded 57721068 bytes. 11:47:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TywIZsxwQtKWExtABuSh_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:47:03 INFO - mkdir: /builds/slave/test-pgo/properties 11:47:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 11:47:03 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 11:47:03 INFO - Contents: 11:47:03 INFO - build_url:https://queue.taskcluster.net/v1/task/TywIZsxwQtKWExtABuSh_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:47:07 INFO - Running post-action listener: _resource_record_post_action 11:47:07 INFO - Running post-action listener: set_extra_try_arguments 11:47:07 INFO - ##### 11:47:07 INFO - ##### Running populate-webroot step. 11:47:07 INFO - ##### 11:47:07 INFO - Running pre-action listener: _resource_record_pre_action 11:47:07 INFO - Running main action method: populate_webroot 11:47:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:47:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:47:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:47:07 INFO - '--tppagecycles', 11:47:07 INFO - '7'], 11:47:07 INFO - 'tests': ['tsvgm']}}, 11:47:07 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:47:07 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:47:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:47:07 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 11:47:07 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:47:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:47:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:47:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:47:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:47:07 INFO - 'talos_options': ['--e10s'], 11:47:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:47:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:47:07 INFO - 'tests': ['damp', 'tps']}, 11:47:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:47:07 INFO - 'talos_options': ['--e10s'], 11:47:07 INFO - 'tests': ['damp', 'tps']}, 11:47:07 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:47:07 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 11:47:07 INFO - 'tests': ['dromaeo_dom']}, 11:47:07 INFO - 'other': {'tests': ['a11yr', 11:47:07 INFO - 'ts_paint', 11:47:07 INFO - 'tpaint', 11:47:07 INFO - 'sessionrestore', 11:47:07 INFO - 'sessionrestore_no_auto_restore', 11:47:07 INFO - 'tabpaint']}, 11:47:07 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:47:07 INFO - 'tests': ['a11yr', 11:47:07 INFO - 'ts_paint', 11:47:07 INFO - 'tpaint', 11:47:07 INFO - 'sessionrestore', 11:47:07 INFO - 'sessionrestore_no_auto_restore', 11:47:07 INFO - 'tabpaint']}, 11:47:07 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:47:07 INFO - 'tests': ['a11yr', 11:47:07 INFO - 'ts_paint', 11:47:07 INFO - 'tpaint', 11:47:07 INFO - 'sessionrestore', 11:47:07 INFO - 'sessionrestore_no_auto_restore', 11:47:07 INFO - 'tabpaint']}, 11:47:07 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:47:07 INFO - 'tests': ['a11yr', 11:47:07 INFO - 'ts_paint', 11:47:07 INFO - 'tpaint', 11:47:07 INFO - 'sessionrestore', 11:47:07 INFO - 'sessionrestore_no_auto_restore', 11:47:07 INFO - 'tabpaint']}, 11:47:07 INFO - 'other_l64': {'tests': ['a11yr', 11:47:07 INFO - 'ts_paint', 11:47:07 INFO - 'tpaint', 11:47:07 INFO - 'sessionrestore', 11:47:07 INFO - 'sessionrestore_no_auto_restore', 11:47:07 INFO - 'tabpaint']}, 11:47:07 INFO - 'other_nol64': {'tests': ['a11yr', 11:47:07 INFO - 'ts_paint', 11:47:07 INFO - 'tpaint', 11:47:07 INFO - 'sessionrestore', 11:47:07 INFO - 'sessionrestore_no_auto_restore', 11:47:07 INFO - 'tabpaint']}, 11:47:07 INFO - 'svgr': {'tests': ['tsvgx', 11:47:07 INFO - 'tsvgr_opacity', 11:47:07 INFO - 'tart', 11:47:07 INFO - 'tscrollx', 11:47:07 INFO - 'cart']}, 11:47:07 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:47:07 INFO - 'tests': ['tsvgx', 11:47:07 INFO - 'tsvgr_opacity', 11:47:07 INFO - 'tart', 11:47:07 INFO - 'tscrollx', 11:47:07 INFO - 'cart']}, 11:47:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:47:07 INFO - 'tests': ['tp5o']}, 11:47:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:47:07 INFO - 'talos_options': ['--e10s'], 11:47:07 INFO - 'tests': ['tp5o']}, 11:47:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:47:07 INFO - 'talos_options': ['--xperf_path', 11:47:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:47:07 INFO - 'tests': ['tp5n']}, 11:47:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:47:07 INFO - 'talos_options': ['--e10s', 11:47:07 INFO - '--xperf_path', 11:47:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:47:07 INFO - 'tests': ['tp5n']}}, 11:47:07 INFO - 'talos.zip': {'path': '', 11:47:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:47:07 INFO - Running post-action listener: _resource_record_post_action 11:47:07 INFO - ##### 11:47:07 INFO - ##### Running create-virtualenv step. 11:47:07 INFO - ##### 11:47:07 INFO - Running pre-action listener: _resource_record_pre_action 11:47:07 INFO - Running main action method: create_virtualenv 11:47:07 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 11:47:07 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 11:47:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 11:47:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:47:07 INFO - Using real prefix '/usr' 11:47:07 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 11:47:08 INFO - Installing distribute.............................................................................................................................................................................................done. 11:47:10 INFO - Installing pip.................done. 11:47:10 INFO - Return code: 0 11:47:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 11:47: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')]} 11:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47: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')]} 11:47:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe063983f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e66b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e11d0>, '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 0x18e4750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e4be0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1458929938.980286-947849827', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:47: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', 'pip>=1.5'] in /builds/slave/test-pgo/build 11:47: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 pip>=1.5 11:47:10 INFO - Using env: {'DISPLAY': ':0', 11:47:10 INFO - 'HOME': '/home/cltbld', 11:47:10 INFO - 'LANG': 'en_US.UTF-8', 11:47:10 INFO - 'LANGUAGE': 'en_US:en', 11:47:10 INFO - 'LOGNAME': 'cltbld', 11:47:10 INFO - 'MAIL': '/var/mail/cltbld', 11:47:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:10 INFO - 'MOZ_NO_REMOTE': '1', 11:47:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:47:10 INFO - 'NO_EM_RESTART': '1', 11:47:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:47:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:47:10 INFO - 'PWD': '/builds/slave/test-pgo', 11:47:10 INFO - 'SHELL': '/bin/bash', 11:47:10 INFO - 'SHLVL': '1', 11:47:10 INFO - 'TERM': 'linux', 11:47:10 INFO - 'TMOUT': '86400', 11:47:10 INFO - 'USER': 'cltbld', 11:47:10 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1458929938.980286-947849827', 11:47:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:10 INFO - '_': '/tools/buildbot/bin/python'} 11:47:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:10 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:47:10 INFO - Cleaning up... 11:47:10 INFO - Return code: 0 11:47:10 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 11:47: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')]} 11:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47: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')]} 11:47:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47: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', '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 0x7fe063983f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e66b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e11d0>, '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 0x18e4750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e4be0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1458929938.980286-947849827', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:47: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', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 11:47: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 psutil>=0.7.1 11:47:10 INFO - Using env: {'DISPLAY': ':0', 11:47:10 INFO - 'HOME': '/home/cltbld', 11:47:10 INFO - 'LANG': 'en_US.UTF-8', 11:47:10 INFO - 'LANGUAGE': 'en_US:en', 11:47:10 INFO - 'LOGNAME': 'cltbld', 11:47:10 INFO - 'MAIL': '/var/mail/cltbld', 11:47:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:10 INFO - 'MOZ_NO_REMOTE': '1', 11:47:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:47:10 INFO - 'NO_EM_RESTART': '1', 11:47:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:47:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:47:10 INFO - 'PWD': '/builds/slave/test-pgo', 11:47:10 INFO - 'SHELL': '/bin/bash', 11:47:10 INFO - 'SHLVL': '1', 11:47:10 INFO - 'TERM': 'linux', 11:47:10 INFO - 'TMOUT': '86400', 11:47:10 INFO - 'USER': 'cltbld', 11:47:10 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1458929938.980286-947849827', 11:47:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:10 INFO - '_': '/tools/buildbot/bin/python'} 11:47:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:10 INFO - Downloading/unpacking psutil>=0.7.1 11:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:47:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 11:47:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:47:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:47:13 INFO - Installing collected packages: psutil 11:47:13 INFO - Running setup.py install for psutil 11:47:13 INFO - building 'psutil._psutil_linux' extension 11:47:13 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:47:13 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:47:13 INFO - building 'psutil._psutil_posix' extension 11:47:13 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:47:13 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:47:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:47:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:47:13 INFO - Successfully installed psutil 11:47:13 INFO - Cleaning up... 11:47:13 INFO - Return code: 0 11:47:13 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 11:47: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')]} 11:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47: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')]} 11:47:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47: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', '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 0x7fe063983f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e66b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e11d0>, '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 0x18e4750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e4be0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1458929938.980286-947849827', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:47: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 11:47: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 mozsystemmonitor==0.0.0 11:47:13 INFO - Using env: {'DISPLAY': ':0', 11:47:13 INFO - 'HOME': '/home/cltbld', 11:47:13 INFO - 'LANG': 'en_US.UTF-8', 11:47:13 INFO - 'LANGUAGE': 'en_US:en', 11:47:13 INFO - 'LOGNAME': 'cltbld', 11:47:13 INFO - 'MAIL': '/var/mail/cltbld', 11:47:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:13 INFO - 'MOZ_NO_REMOTE': '1', 11:47:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:47:13 INFO - 'NO_EM_RESTART': '1', 11:47:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:47:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:47:13 INFO - 'PWD': '/builds/slave/test-pgo', 11:47:13 INFO - 'SHELL': '/bin/bash', 11:47:13 INFO - 'SHLVL': '1', 11:47:13 INFO - 'TERM': 'linux', 11:47:13 INFO - 'TMOUT': '86400', 11:47:13 INFO - 'USER': 'cltbld', 11:47:13 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1458929938.980286-947849827', 11:47:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:13 INFO - '_': '/tools/buildbot/bin/python'} 11:47:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:14 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:47:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:16 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:47:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:47:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:47:16 INFO - Installing collected packages: mozsystemmonitor 11:47:16 INFO - Running setup.py install for mozsystemmonitor 11:47:16 INFO - Successfully installed mozsystemmonitor 11:47:16 INFO - Cleaning up... 11:47:16 INFO - Return code: 0 11:47:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 11:47: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')]} 11:47:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47: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')]} 11:47:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:16 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe063983f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e66b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e11d0>, '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 0x18e4750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e4be0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1458929938.980286-947849827', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:47:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 11:47:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:47:16 INFO - Using env: {'DISPLAY': ':0', 11:47:16 INFO - 'HOME': '/home/cltbld', 11:47:16 INFO - 'LANG': 'en_US.UTF-8', 11:47:16 INFO - 'LANGUAGE': 'en_US:en', 11:47:16 INFO - 'LOGNAME': 'cltbld', 11:47:16 INFO - 'MAIL': '/var/mail/cltbld', 11:47:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:16 INFO - 'MOZ_NO_REMOTE': '1', 11:47:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:47:16 INFO - 'NO_EM_RESTART': '1', 11:47:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:47:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:47:16 INFO - 'PWD': '/builds/slave/test-pgo', 11:47:16 INFO - 'SHELL': '/bin/bash', 11:47:16 INFO - 'SHLVL': '1', 11:47:16 INFO - 'TERM': 'linux', 11:47:16 INFO - 'TMOUT': '86400', 11:47:16 INFO - 'USER': 'cltbld', 11:47:16 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1458929938.980286-947849827', 11:47:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:16 INFO - '_': '/tools/buildbot/bin/python'} 11:47:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:16 INFO - Downloading/unpacking blobuploader==1.2.4 11:47:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:47:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:47:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:18 INFO - Downloading blobuploader-1.2.4.tar.gz 11:47:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:47:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:47:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:47:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:47:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 11:47:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:47:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:47:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:47:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:19 INFO - Downloading docopt-0.6.1.tar.gz 11:47:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 11:47:19 INFO - Installing collected packages: blobuploader, requests, docopt 11:47:19 INFO - Running setup.py install for blobuploader 11:47:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:47:19 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 11:47:19 INFO - Running setup.py install for requests 11:47:20 INFO - Running setup.py install for docopt 11:47:20 INFO - Successfully installed blobuploader requests docopt 11:47:20 INFO - Cleaning up... 11:47:20 INFO - Return code: 0 11:47:20 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:47:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:47:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:47:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:20 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 0x7fe063983f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e66b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e11d0>, '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 0x18e4750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e4be0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1458929938.980286-947849827', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:47:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 11:47:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:47:20 INFO - Using env: {'DISPLAY': ':0', 11:47:20 INFO - 'HOME': '/home/cltbld', 11:47:20 INFO - 'LANG': 'en_US.UTF-8', 11:47:20 INFO - 'LANGUAGE': 'en_US:en', 11:47:20 INFO - 'LOGNAME': 'cltbld', 11:47:20 INFO - 'MAIL': '/var/mail/cltbld', 11:47:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:20 INFO - 'MOZ_NO_REMOTE': '1', 11:47:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:47:20 INFO - 'NO_EM_RESTART': '1', 11:47:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:47:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:47:20 INFO - 'PWD': '/builds/slave/test-pgo', 11:47:20 INFO - 'SHELL': '/bin/bash', 11:47:20 INFO - 'SHLVL': '1', 11:47:20 INFO - 'TERM': 'linux', 11:47:20 INFO - 'TMOUT': '86400', 11:47:20 INFO - 'USER': 'cltbld', 11:47:20 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1458929938.980286-947849827', 11:47:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:20 INFO - '_': '/tools/buildbot/bin/python'} 11:47:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:47:20 INFO - Running setup.py (path:/tmp/pip-g6_0IM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:47:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:47:20 INFO - Running setup.py (path:/tmp/pip-mGPDiv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:47:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:47:20 INFO - Running setup.py (path:/tmp/pip-LNgyf9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:47:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:47:20 INFO - Running setup.py (path:/tmp/pip-Cepwhk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:47:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:47:20 INFO - Running setup.py (path:/tmp/pip-3KH_vl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:47:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:47:20 INFO - Running setup.py (path:/tmp/pip-qtD5tJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:47:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:47:20 INFO - Running setup.py (path:/tmp/pip-YbIHcS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:47:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:47:21 INFO - Running setup.py (path:/tmp/pip-x7JSli-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:47:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:47:21 INFO - Running setup.py (path:/tmp/pip-smc0tW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:47:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:47:21 INFO - Running setup.py (path:/tmp/pip-Snch5W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:47:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:47:21 INFO - Running setup.py (path:/tmp/pip-tv_Hyc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:47:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:47:21 INFO - Running setup.py (path:/tmp/pip-dweC93-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:47:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:47:21 INFO - Running setup.py (path:/tmp/pip-A9pFa2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:47:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:47:21 INFO - Running setup.py (path:/tmp/pip-boNRI8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:47:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:47:21 INFO - Running setup.py (path:/tmp/pip-ewoDV8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:47:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:47:21 INFO - Running setup.py (path:/tmp/pip-hnNKzn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:47:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:47:21 INFO - Running setup.py (path:/tmp/pip-2C7XvI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:47:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:47:21 INFO - Running setup.py install for manifestparser 11:47:21 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 11:47:21 INFO - Running setup.py install for mozcrash 11:47:21 INFO - Running setup.py install for mozdebug 11:47:22 INFO - Running setup.py install for mozdevice 11:47:22 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 11:47:22 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 11:47:22 INFO - Running setup.py install for mozfile 11:47:22 INFO - Running setup.py install for mozhttpd 11:47:22 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 11:47:22 INFO - Running setup.py install for mozinfo 11:47:22 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 11:47:22 INFO - Running setup.py install for mozInstall 11:47:22 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 11:47:22 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 11:47:22 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 11:47:22 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 11:47:22 INFO - Running setup.py install for mozleak 11:47:22 INFO - Running setup.py install for mozlog 11:47:22 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 11:47:22 INFO - Running setup.py install for moznetwork 11:47:22 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 11:47:22 INFO - Running setup.py install for mozprocess 11:47:22 INFO - Running setup.py install for mozprofile 11:47:23 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 11:47:23 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 11:47:23 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 11:47:23 INFO - Running setup.py install for mozrunner 11:47:23 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 11:47:23 INFO - Running setup.py install for mozscreenshot 11:47:23 INFO - Running setup.py install for moztest 11:47:23 INFO - Running setup.py install for mozversion 11:47:23 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 11:47:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:47:23 INFO - Cleaning up... 11:47:23 INFO - Return code: 0 11:47:23 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:47: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')]} 11:47:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47: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')]} 11:47:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47: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/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 0x7fe063983f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e66b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e11d0>, '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 0x18e4750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e4be0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1458929938.980286-947849827', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:47:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 11:47:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:47:23 INFO - Using env: {'DISPLAY': ':0', 11:47:23 INFO - 'HOME': '/home/cltbld', 11:47:23 INFO - 'LANG': 'en_US.UTF-8', 11:47:23 INFO - 'LANGUAGE': 'en_US:en', 11:47:23 INFO - 'LOGNAME': 'cltbld', 11:47:23 INFO - 'MAIL': '/var/mail/cltbld', 11:47:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:23 INFO - 'MOZ_NO_REMOTE': '1', 11:47:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:47:23 INFO - 'NO_EM_RESTART': '1', 11:47:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:47:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:47:23 INFO - 'PWD': '/builds/slave/test-pgo', 11:47:23 INFO - 'SHELL': '/bin/bash', 11:47:23 INFO - 'SHLVL': '1', 11:47:23 INFO - 'TERM': 'linux', 11:47:23 INFO - 'TMOUT': '86400', 11:47:23 INFO - 'USER': 'cltbld', 11:47:23 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1458929938.980286-947849827', 11:47:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:23 INFO - '_': '/tools/buildbot/bin/python'} 11:47:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:47:23 INFO - Running setup.py (path:/tmp/pip-1JOkvZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:47:23 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 11:47:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:47:23 INFO - Running setup.py (path:/tmp/pip-lHVZdZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:47:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 11:47:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:47:23 INFO - Running setup.py (path:/tmp/pip-RKKCsN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:47:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 11:47:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:47:23 INFO - Running setup.py (path:/tmp/pip-ntI9Ny-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:47:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 11:47:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:47:24 INFO - Running setup.py (path:/tmp/pip-XT9ICn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:47:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 11:47:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:47:24 INFO - Running setup.py (path:/tmp/pip-oJr1h2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:47:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 11:47:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:47:24 INFO - Running setup.py (path:/tmp/pip-VNqRda-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:47:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 11:47:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:47:24 INFO - Running setup.py (path:/tmp/pip-v8OmrK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:47:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 11:47:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:47:24 INFO - Running setup.py (path:/tmp/pip-NwJXKO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:47:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 11:47:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:47:24 INFO - Running setup.py (path:/tmp/pip-t_MGjT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:47:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 11:47:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:47:24 INFO - Running setup.py (path:/tmp/pip-B6afGc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:47:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 11:47:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:47:24 INFO - Running setup.py (path:/tmp/pip-Zu79KH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:47:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 11:47:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:47:24 INFO - Running setup.py (path:/tmp/pip-k2Zd1n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:47:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 11:47:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:47:24 INFO - Running setup.py (path:/tmp/pip-y09hYf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:47:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 11:47:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:47:24 INFO - Running setup.py (path:/tmp/pip-OYlk6t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:47:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 11:47:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:47:24 INFO - Running setup.py (path:/tmp/pip-lUiOOj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:47:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 11:47:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:47:24 INFO - Running setup.py (path:/tmp/pip-6ey507-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:47:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 11:47:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 11:47:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 11:47:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 11:47:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 11:47:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 11:47:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 11:47: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 11:47: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 11:47: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 11:47: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 11:47: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 11:47: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 11:47:27 INFO - Downloading blessings-1.6.tar.gz 11:47:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 11:47:27 INFO - Installing collected packages: blessings 11:47:27 INFO - Running setup.py install for blessings 11:47:27 INFO - Successfully installed blessings 11:47:27 INFO - Cleaning up... 11:47:27 INFO - Return code: 0 11:47:27 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 11:47:27 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:47:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:47:27 INFO - Reading from file tmpfile_stdout 11:47:27 INFO - Current package versions: 11:47:27 INFO - argparse == 1.2.1 11:47:27 INFO - blessings == 1.6 11:47:27 INFO - blobuploader == 1.2.4 11:47:27 INFO - docopt == 0.6.1 11:47:27 INFO - manifestparser == 1.1 11:47:27 INFO - mozInstall == 1.12 11:47:27 INFO - mozcrash == 0.17 11:47:27 INFO - mozdebug == 0.1 11:47:27 INFO - mozdevice == 0.48 11:47:27 INFO - mozfile == 1.2 11:47:27 INFO - mozhttpd == 0.7 11:47:27 INFO - mozinfo == 0.9 11:47:27 INFO - mozleak == 0.1 11:47:27 INFO - mozlog == 3.1 11:47:27 INFO - moznetwork == 0.27 11:47:27 INFO - mozprocess == 0.22 11:47:27 INFO - mozprofile == 0.28 11:47:27 INFO - mozrunner == 6.11 11:47:27 INFO - mozscreenshot == 0.1 11:47:27 INFO - mozsystemmonitor == 0.0 11:47:27 INFO - moztest == 0.7 11:47:27 INFO - mozversion == 1.4 11:47:27 INFO - psutil == 3.1.1 11:47:27 INFO - requests == 1.2.3 11:47:27 INFO - wsgiref == 0.1.2 11:47:27 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:47:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:47:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:47:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:27 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 0x7fe063983f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e66b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e11d0>, '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 0x18e4750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e4be0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1458929938.980286-947849827', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:47:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 11:47:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:47:27 INFO - Using env: {'DISPLAY': ':0', 11:47:27 INFO - 'HOME': '/home/cltbld', 11:47:27 INFO - 'LANG': 'en_US.UTF-8', 11:47:27 INFO - 'LANGUAGE': 'en_US:en', 11:47:27 INFO - 'LOGNAME': 'cltbld', 11:47:27 INFO - 'MAIL': '/var/mail/cltbld', 11:47:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:27 INFO - 'MOZ_NO_REMOTE': '1', 11:47:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:47:27 INFO - 'NO_EM_RESTART': '1', 11:47:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:47:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:47:27 INFO - 'PWD': '/builds/slave/test-pgo', 11:47:27 INFO - 'SHELL': '/bin/bash', 11:47:27 INFO - 'SHLVL': '1', 11:47:27 INFO - 'TERM': 'linux', 11:47:27 INFO - 'TMOUT': '86400', 11:47:27 INFO - 'USER': 'cltbld', 11:47:27 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1458929938.980286-947849827', 11:47:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:27 INFO - '_': '/tools/buildbot/bin/python'} 11:47:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 11:47:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 11:47:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 11:47:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 11:47:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 11:47:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 11:47:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 11:47:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 11:47:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 11:47:27 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 11:47:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 11:47:27 INFO - Cleaning up... 11:47:27 INFO - Return code: 0 11:47:27 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 11:47:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:47:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:47:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:27 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 0x7fe063983f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e66b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e11d0>, '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 0x18e4750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e4be0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1458929938.980286-947849827', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:47:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 11:47:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:47:27 INFO - Using env: {'DISPLAY': ':0', 11:47:27 INFO - 'HOME': '/home/cltbld', 11:47:27 INFO - 'LANG': 'en_US.UTF-8', 11:47:27 INFO - 'LANGUAGE': 'en_US:en', 11:47:27 INFO - 'LOGNAME': 'cltbld', 11:47:27 INFO - 'MAIL': '/var/mail/cltbld', 11:47:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:27 INFO - 'MOZ_NO_REMOTE': '1', 11:47:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:47:27 INFO - 'NO_EM_RESTART': '1', 11:47:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:47:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:47:27 INFO - 'PWD': '/builds/slave/test-pgo', 11:47:27 INFO - 'SHELL': '/bin/bash', 11:47:27 INFO - 'SHLVL': '1', 11:47:27 INFO - 'TERM': 'linux', 11:47:27 INFO - 'TMOUT': '86400', 11:47:27 INFO - 'USER': 'cltbld', 11:47:27 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1458929938.980286-947849827', 11:47:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:27 INFO - '_': '/tools/buildbot/bin/python'} 11:47:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:28 INFO - Downloading/unpacking jsonschema 11:47: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 11:47: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 11:47: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 11:47: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 11:47: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 11:47: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 11:47:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:47:30 INFO - Downloading/unpacking functools32 (from jsonschema) 11:47:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:47:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:47:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:30 INFO - Downloading functools32-3.2.3-2.tar.gz 11:47:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 11:47:31 INFO - warning: no files found matching '*.txt' 11:47:31 INFO - no previously-included directories found matching 'build' 11:47:31 INFO - no previously-included directories found matching 'dist' 11:47:31 INFO - no previously-included directories found matching '.git*' 11:47:31 INFO - Installing collected packages: jsonschema, functools32 11:47:31 INFO - Running setup.py install for functools32 11:47:31 INFO - warning: no files found matching '*.txt' 11:47:31 INFO - no previously-included directories found matching 'build' 11:47:31 INFO - no previously-included directories found matching 'dist' 11:47:31 INFO - no previously-included directories found matching '.git*' 11:47:31 INFO - Successfully installed jsonschema functools32 11:47:31 INFO - Cleaning up... 11:47:31 INFO - Return code: 0 11:47:31 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 11:47:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:47:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:47:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:31 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 0x7fe063983f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e66b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e11d0>, '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 0x18e4750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e4be0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1458929938.980286-947849827', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:47:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 11:47:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:47:31 INFO - Using env: {'DISPLAY': ':0', 11:47:31 INFO - 'HOME': '/home/cltbld', 11:47:31 INFO - 'LANG': 'en_US.UTF-8', 11:47:31 INFO - 'LANGUAGE': 'en_US:en', 11:47:31 INFO - 'LOGNAME': 'cltbld', 11:47:31 INFO - 'MAIL': '/var/mail/cltbld', 11:47:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:31 INFO - 'MOZ_NO_REMOTE': '1', 11:47:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:47:31 INFO - 'NO_EM_RESTART': '1', 11:47:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:47:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:47:31 INFO - 'PWD': '/builds/slave/test-pgo', 11:47:31 INFO - 'SHELL': '/bin/bash', 11:47:31 INFO - 'SHLVL': '1', 11:47:31 INFO - 'TERM': 'linux', 11:47:31 INFO - 'TMOUT': '86400', 11:47:31 INFO - 'USER': 'cltbld', 11:47:31 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1458929938.980286-947849827', 11:47:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:31 INFO - '_': '/tools/buildbot/bin/python'} 11:47:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:31 INFO - Downloading/unpacking flake8 11:47:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:47:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:47:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:34 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:47:34 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:47:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:47:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:47:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:34 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:47:34 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:47:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:47:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:47:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:34 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:47:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:47:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:47:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 11:47:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:47:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:47:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:47:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:47:35 INFO - no previously-included directories found matching 'docs/_build' 11:47:35 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:47:35 INFO - Running setup.py install for pep8 11:47:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:47:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:47:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:47:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:47:35 INFO - no previously-included directories found matching 'docs/_build' 11:47:35 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 11:47:35 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:47:35 INFO - Cleaning up... 11:47:35 INFO - Return code: 0 11:47:35 INFO - Running post-action listener: _resource_record_post_action 11:47:35 INFO - Running post-action listener: _start_resource_monitoring 11:47:35 INFO - Starting resource monitoring. 11:47:35 INFO - ##### 11:47:35 INFO - ##### Running install step. 11:47:35 INFO - ##### 11:47:35 INFO - Running pre-action listener: _resource_record_pre_action 11:47:35 INFO - Running main action method: install 11:47:35 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:47:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:47:35 INFO - Reading from file tmpfile_stdout 11:47:35 INFO - Detecting whether we're running mozinstall >=1.0... 11:47:35 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 11:47:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 11:47:35 INFO - Reading from file tmpfile_stdout 11:47:35 INFO - Output received: 11:47:35 INFO - Usage: mozinstall [options] installer 11:47:35 INFO - Options: 11:47:35 INFO - -h, --help show this help message and exit 11:47:35 INFO - -d DEST, --destination=DEST 11:47:35 INFO - Directory to install application into. [default: 11:47:35 INFO - "/builds/slave/test-pgo"] 11:47:35 INFO - --app=APP Application being installed. [default: firefox] 11:47:35 INFO - mkdir: /builds/slave/test-pgo/build/application 11:47:35 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 11:47:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 11:47:52 INFO - Reading from file tmpfile_stdout 11:47:52 INFO - Output received: 11:47:52 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 11:47:52 INFO - Running post-action listener: _resource_record_post_action 11:47:52 INFO - ##### 11:47:52 INFO - ##### Running run-tests step. 11:47:52 INFO - ##### 11:47:52 INFO - Running pre-action listener: _resource_record_pre_action 11:47:52 INFO - Running main action method: run_tests 11:47:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 11:47:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 11:47:52 INFO - Python 2.7.3 11:47:52 INFO - Return code: 0 11:47:52 INFO - grabbing minidump binary from tooltool 11:47:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:47:52 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 0x18e11d0>, '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 0x18e4750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e4be0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 11:47:52 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 11:47:52 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:47:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:47:52 INFO - Return code: 0 11:47:52 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 11:47:52 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 11:47:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 11:47:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 11:47:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 11:47:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 11:47:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 11:47:53 INFO - Return code: 0 11:47:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TywIZsxwQtKWExtABuSh_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 11:47:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TywIZsxwQtKWExtABuSh_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --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 11:47:53 INFO - Using env: {'DISPLAY': ':0', 11:47:53 INFO - 'HOME': '/home/cltbld', 11:47:53 INFO - 'LANG': 'en_US.UTF-8', 11:47:53 INFO - 'LANGUAGE': 'en_US:en', 11:47:53 INFO - 'LOGNAME': 'cltbld', 11:47:53 INFO - 'MAIL': '/var/mail/cltbld', 11:47:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:47:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 11:47:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:53 INFO - 'MOZ_NO_REMOTE': '1', 11:47:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:47:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:47:53 INFO - 'NO_EM_RESTART': '1', 11:47:53 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:47:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:47:53 INFO - 'PWD': '/builds/slave/test-pgo', 11:47:53 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 11:47:53 INFO - 'SHELL': '/bin/bash', 11:47:53 INFO - 'SHLVL': '1', 11:47:53 INFO - 'TERM': 'linux', 11:47:53 INFO - 'TMOUT': '86400', 11:47:53 INFO - 'USER': 'cltbld', 11:47:53 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1458929938.980286-947849827', 11:47:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:53 INFO - '_': '/tools/buildbot/bin/python'} 11:47:53 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TywIZsxwQtKWExtABuSh_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 11:47:53 INFO - mozversion application_buildid: 20160325083832 11:47:53 INFO - mozversion application_changeset: b2dbee5ca727e87bdaeab9ab60fb83df2a9846a2 11:47:53 INFO - mozversion application_display_name: Nightly 11:47:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:47:53 INFO - mozversion application_name: Firefox 11:47:53 INFO - mozversion application_remotingname: firefox 11:47:53 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:47:53 INFO - mozversion application_vendor: Mozilla 11:47:53 INFO - mozversion application_version: 48.0a1 11:47:53 INFO - mozversion platform_buildid: 20160325083832 11:47:53 INFO - mozversion platform_changeset: b2dbee5ca727e87bdaeab9ab60fb83df2a9846a2 11:47:53 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:47:53 INFO - mozversion platform_version: 48.0a1 11:47:53 INFO - using testdate: 1458931673 11:47:53 INFO - actual date: 1458931673 11:47:53 INFO - starting webserver on 'localhost:48486' 11:47:53 INFO - SUITE-START | Running 2 tests 11:47:53 INFO - TEST-START | dromaeo_css 11:47:53 INFO - operating with platform_type : linux_ 11:47:53 INFO - Initialising browser for dromaeo_css test... 11:47:53 INFO - TEST-INFO | started process 7022 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4miQZx/profile http://localhost:48486/getInfo.html) 11:47:58 INFO - PROCESS | 7022 | __metrics Screen width/height:1600/1200 11:47:58 INFO - PROCESS | 7022 | colorDepth:24 11:47:58 INFO - PROCESS | 7022 | Browser inner width/height: 1024/697 11:47:58 INFO - PROCESS | 7022 | __metrics 11:47:59 ERROR - PROCESS | 7022 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:47:59 INFO - TEST-INFO | 7022: exit 0 11:47:59 INFO - Browser initialized. 11:47:59 INFO - Running cycle 1/1 for dromaeo_css test... 11:47:59 INFO - TEST-INFO | started process 7116 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4miQZx/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:48:11 INFO - PROCESS | 7116 | RSS: Main: 153104384 11:48:11 INFO - PROCESS | 7116 | 11:49:02 INFO - PROCESS | 7116 | 1458931742301 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:51:10 INFO - PROCESS | 7116 | Cycle 1(1): loaded http://localhost:48486/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48486/tests/dromaeo/cssquery-ext.html) 11:51:11 INFO - PROCESS | 7116 | RSS: Main: 258465792 11:51:11 INFO - PROCESS | 7116 | 11:54:13 INFO - PROCESS | 7116 | Cycle 1(1): loaded http://localhost:48486/tests/dromaeo/cssquery-ext.html (next: http://localhost:48486/tests/dromaeo/cssquery-jquery.html) 11:54:13 INFO - PROCESS | 7116 | RSS: Main: 232083456 11:54:13 INFO - PROCESS | 7116 | 11:57:15 INFO - PROCESS | 7116 | Cycle 1(1): loaded http://localhost:48486/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48486/tests/dromaeo/cssquery-mootools.html) 11:57:16 INFO - PROCESS | 7116 | RSS: Main: 241258496 11:57:16 INFO - PROCESS | 7116 | 12:00:18 INFO - PROCESS | 7116 | Cycle 1(1): loaded http://localhost:48486/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48486/tests/dromaeo/cssquery-prototype.html) 12:00:18 INFO - PROCESS | 7116 | RSS: Main: 220643328 12:00:18 INFO - PROCESS | 7116 | 12:03:21 INFO - PROCESS | 7116 | Cycle 1(1): loaded http://localhost:48486/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48486/tests/dromaeo/cssquery-yui.html) 12:03:21 INFO - PROCESS | 7116 | RSS: Main: 215195648 12:03:21 INFO - PROCESS | 7116 | 12:06:24 INFO - PROCESS | 7116 | Cycle 1(1): loaded http://localhost:48486/tests/dromaeo/cssquery-yui.html (next: http://localhost:48486/tests/dromaeo/cssquery-dojo.html) 12:06:24 INFO - PROCESS | 7116 | RSS: Main: 261632000 12:06:24 INFO - PROCESS | 7116 | 12:06:24 INFO - PROCESS | 7116 | __start_tp_report 12:06:24 INFO - PROCESS | 7116 | _x_x_mozilla_page_load 12:06:24 INFO - PROCESS | 7116 | _x_x_mozilla_page_load_details 12:06:24 INFO - PROCESS | 7116 | |i|pagename|runs| 12:06:24 INFO - PROCESS | 7116 | |0;dojo.html;3014.6985301469854;3063.586415833862;3105.9068227953153;3107.0523490335454;3132.3108916038473;5112.105381558231;5251;5251.0810608143565;5279.20811878218;5288.867778305545;5267.710275934822;5283.418823929364;5292.047431462335;5307.363116426034;5321.3348331458565;4651.186042442576;4684.929726054112;4791.089692958327;4795.832145874878;4837;4659.138059458994;4777.402824646919;4788.736619485927;4810.951890481086;4826.396700412449;4721.952780472186;4745.288206768978;4761.4524329701835;4763.404574428197;4798.136335459616;4792.041591681677;4795.688280261772;4803.927941080887;4805.471398146201;4808.2547205183255;4623.260278355447;4691.695039822401;4775;4783.115123702126;4810.302506136591;5199.194124910645;5202.219667049935;5222.8694282642855;5236.319278493809;5240.161574148156;5622.465865742748;5656.604037717361;5658.547316214693;5662.66024038559;5670.376258611549;5478.671279723229;5696.943030569682;5714.599978001542;5774.913376299359;5787.565932555033;5223.791048358061;5230.7969167091405;5236.423993360727;5236.633435659505;5239.79040838366;5708.31500219968;5714.314282286069;5715.057015592381;5716.114002329646;5720.313562372542;5426.050441172779;5474.288342515448;5486.61593688438;5526.47498487643;5531.723413829292;5648.85877853057;5665.716714164275;5678.346990096109;5679.801206957736;5683.687397193112;5520.1443776214755;5618.297712785902;5634.126710359901;5646.322441307069;5649.12438572022;5471.06991811393;5518.779248830002;5526.613137080366;5541.750621222055;5566.165075238666;4289.935650965238;4290.034742182984;4301.161273551627;4301.569843015736;4343.9348409773875;3759.3045286622064;3801.3727734923427;3849.4610754494392;3871.690264778811;3879.631435013669;5306.071437498499;5332.520073193431;5351.785928562892;5376.139817629239;5377.435369286247;5577.6653400796085;5604.887902241932;5633.436656334334;5647.011772939719;5649.067903795828;5202.739863006835;5288.021715982555;5289.994900968803;5295.973520132375;5335.5464785492895;4812.614990800797;4850.684705494202;4850.708957462563;4855.101806165871;4898.657094003385;5676.318841739017;5706.543476521868;5709.8287051388525;5714.314282286152;5769.509591684669;5514.338279406497;5609.523190528851;5617.43825617435;5639.6334238274385;5744.13837924298;5805.912911306418;5812.564057695605;5818.301803783573;5821.301443826768;5828;5570.2201691762375;5583.692896890548;5590.972045139748;5596.496315331639;5598.412166722598;5563.388027317073;5629.8592535186945;5647.5481961442165;5721.799737009184;5733.598648094593;5533.446655334435;5540.36285827135;5540.833774986757;5541.030319694118;5544.0575102231915;5498.395176530658;5504.752286147213;5505;5509.834704958857;5512.200730894078;5269.235960785742;5370.785168593213;5444.6188766785945;5462.0441422751655;5478.863028424321;5539.335279766454;5556.694381809039;5566.749496272759;5570.303712035996;5580.665160090408;5358.089124848863;5447.428020057837;5464.672119672832;5468.562514998711;5512.283403157724 12:06:24 INFO - PROCESS | 7116 | |1;ext.html;550.8902866066596;573.5927491481051;578.7974209026842;591.051362563086;610.712964906494;30259.69740302599;30295.69704302959;30340.696593034063;30362.089137325915;38289.23421531568;40259;40772.59227407725;40789.59210407895;40796.59203407965;40959.795201024026;8547.059823419419;8750.431221970552;8750.86873696895;8762.079981601935;8767.95616021919;8618.138186181395;8678.956605216965;8716.912830871674;8771.16673915977;8792.208701216889;8723.476591404537;8768.649254029831;8771.16673915977;8795.78010549735;8948.910510894873;8867.467951922874;8920.509371984539;8927.33045021626;8938.419002764833;8948.552572371387;8813.338999574993;8903.777405564848;8945.55272236392;8947.64209431622;8951.776205594848;41460.37809432861;41648.37527437091;41709;41844.372334415006;41868.79065604653;3485.4771784232316;3595.9640403596154;3653.3971894637352;3655.2689462107683;3675.5405574303213;29829;30072.248193795112;30218.69781302181;30278.84860575705;30615.627348606664;4288.785560721952;4331.523532411432;4399.1641588098155;4410.316400957857;4461.442319710036;309436;314999;315658;315875;316217;58317.41682583205;65997.34002659912;66795.65054368204;66906;67009.6649516759;71999;72808.99550524772;72836.27163728295;72899.27100728925;72960.63519682367;16703.83296167023;16705.83294167067;16836.158192090592;16939.661206776043;16954.23705933236;12459.813102803466;12735.29955852437;12979.935100324627;13092.869071309355;13100.475980960846;21382.572348553254;21860;21934.122635094736;21962.231321903655;21970.45073873134;7547.471676982668;7965.442419030728;8053.1946805319;8539.573021348908;8583.613737381833;945.1021529546958;1015.3653966271081;1015.7206768138673;1044.7962647283707;1174.8531433570804;29776.553351699742;29853;29915.850420747756;30452.54321185184;30477.08568742941;1097.7036200225893;1114.8829372915889;1131.9490622921987;1173.3957012138756;1191.7497325561728;15876.44432444882;16419.096949667644;16443.506694799176;16665.25006374716;16690;416165;785224;797066;798229;799180;58582.707086464296;59028.40971590315;59394.703026485455;59401.70299148563;59470.702646487356;1192.1476144556511;1301.3298151452009;1377.1048818268005;1406.9226192559508;1423.6583220027326;29360.41279174447;30401.543976840807;30633.23416914595;30841.42346560943;32930.835345824074;46590;47121;47169.76415117903;47191.76404117957;47217.291740624605;295583;295813;296297;296794;296853;32492.350152996336;36418.8179059103;36423.81788091043;36691.26617467689;36813.631863682094;42827.73025661453;44213;44426.11147777091;45137;45186.09627807359;37372.813135935234;37391.25217495689;37519.06202344963;37663.246735065695;38035.809820950715;37115.81442092772;37161.442578361886;37667;37750;37896.81051594725;37740.05649858776;38139.61860381361;38240.80879595584;38788.41817372685;38927;33004.1748956278;33592.656293747976;34041.48937765886;34137;34236.657633424344;25648.61527077058;25992.22023339303;26322.868385658716;27451.862740686167;27803.860980694968 12:06:24 INFO - PROCESS | 7116 | |2;jquery.html;355.25573922632094;359.9992022178345;362.77145398399006;368.87273890507765;369.65621971566446;17051.403200887973;17161;18201.27194912202;18223.726644100334;18227.36204232852;15300.770488442682;15771.290291936863;15804;15806.920965395186;15815.762763558527;4904.509549045085;5359.866003349908;5662.263905692254;5662.631928924628;5666.914996275059;4106.691998100139;6028.969855150718;6230.5950113242725;6253.530985176108;6261.405166509197;5920.319163296233;6185.195924529805;6187.876242475148;6214.5649804513705;6218.657973811439;5970.641761494303;5972.522198224132;5990.490808281302;5997.040473524237;6010.218671572711;3654.14127679995;3781.716371272166;5261.500157485033;5437.483439073281;5450.809221677222;19804.40586782399;19832;19874.80125198744;20221.79778202214;20237.49406264855;2317.2584772872688;2335.089315167086;2447.278052974377;2976.7023297670275;3059.9809994677844;12939.935300323532;13014.609561713163;13180.275084870329;13212;13439.26084065376;1891.5649400637792;1919.7504324437873;1992.203118752496;2009.1159889648654;2024.0790440349606;63792.681036594986;65632;66388;67089.99365009577;68550;9217.815643687089;9248.491332976751;9261.907380926104;9359.719208423758;9549;12173.817392739116;12252.978258587233;12260.203086799329;12266;12338.938305308595;7455.217202193691;7481.9251807482315;7555.433342499335;7635.656395462218;7778.377729781717;7675.53946763196;7770.689172433153;7775.5723435210475;7880.64537095832;7912.09010963735;5697.4587414195585;5704.572157088235;5716.542676585863;5749.9712501437225;5802.622829516068;1567.5689185474087;1694.3392077089945;1794.97307540387;1809.2310767923843;1845.317232623911;995.1541189988452;1009.2985375164337;1031.8142734307746;1042.5152304178594;1074.7259448840496;17258.568535786704;17436.564085897953;17463.912680436515;17905.462836114937;18322.083895805157;1009.4094954451581;1016.9186465082776;1042.0985847242082;1077.385890042668;1111.6887271563976;10156.796864062677;10546.156307495383;10566.31318964265;10574.418406987535;10575.524101415454;518048;539620;553881;558241;573598;69883;72199.2780072203;72554.63722681353;72946.27053729501;73051.63474182595;1080.6001779341536;1088.3034857691084;1104.928179668319;1120.882307357732;1121.5513794482272;16221;16293.26680299413;16356.427525036566;16443.58891027734;16563.171841407642;22019.779802202414;22508;32411.18972025718;33470.330593388484;35549.466757999166;46178.53821461877;46451.76774116108;46718.76640616911;46814.297785532566;47188;7531.585762783099;7733.729319473791;7743.728969486041;7836.882446763189;7915.287624113857;6675.7329706813125;8129.67481300765;8877.73366798997;11292;11691.123165762432;10755.19336049815;10928.289661171999;10995.835062473909;11010.119190464904;11165.218434709492;10483.056524912794;10619.876024794918;10767.461626918466;11178.832317515407;11371.43142842838;10770.784584308427;11004.834927475935;11185.105191584491;11193;11466;7307.123145222395;7317.0487836580905;7490.625468726651;7599.392048636207;7611.010568626265;10391.948040259751;10475.842862357224;10483.947580262049;10493.265471416928;10587.841182382117 12:06:24 INFO - PROCESS | 7116 | |3;mootools.html;1373.7733274009788;1496.1845794042247;1509.1774982634463;1663.5508412728564;1793.730940358946;7904.881426778603;8085.919140808597;8089.231523005313;8097.392695547843;8106;7744.767656970286;7890.5265684058995;7895.64469598868;7899.960500197505;7910.644021019054;2002.519395345114;2047.2834507922257;2240.641497360423;2252.9436764080865;2268.875211863347;2283.292179424384;2284.2804516577226;2291.8166546676307;2298.747137814839;2302.792748652621;2224.8887555622237;2247.5841969235744;2337.6960995070704;2338.672585837984;2339.146211632759;2270.7502174760843;2299.022915261016;2307.4231442139467;2327.7788610082184;2328.953420931589;2243.4054975431523;2257.661350797377;2260.988695056514;2265.886705664727;2268.410213344526;8252.133525979745;8293.460925039853;8307.376946728959;8310.085890552094;8312.625931833081;4915.9754201229125;5071.695698258116;5074.416442109168;5076.13705670037;5077.796888124508;3256.56036435083;3335.8832440864694;3396.100033491127;3406.029281654741;3426.5202871597994;1163.168334640736;1163.5055101581793;1174.653477224221;1198.5864876617552;1199.8800119988018;10649.733756656067;10695.518701658522;10761.784764304748;10764.13886889047;10778.838317425245;4287.292596721506;4383.057642606855;4412.0955204183065;4457;4462.732236065846;9267.76830579241;9289.72130836076;9343.766405839773;9362.95318523403;9370.062993700712;4923;4944.975275123601;4948.802047918115;4949.985253023122;4958.851234462972;4110.609492098246;4607.8848028798875;4660.04469083837;4685.226937555333;4702.15361234981;3736.75711078779;3821.808909554511;3824.101336185994;3847.8076096195077;3877.360235561101;1202.9097817663535;1222.4315693202525;1223.9632811015683;1231.2181764579377;1231.2735486063266;1390.8551275364518;1402.656349194454;1420.595130387855;1431.1270125223605;1437.2669938331526;7994.5203287802915;8205.425620206648;8220.465669731568;8224.712135075244;8229.341652667772;1057.3655806516028;1143.6397534776518;1145.6448500964727;1150.8216226484908;1154.717094311899;6345.270293916259;6371.52213583983;6406.167198264196;6417.069524918954;6431.903521447182;9159.587818548182;9305.441673499612;9414.105659962293;9419.952900235592;9448.811023779623;9223.815523689624;9356.859647105299;9361.719148425558;9372.34393592442;9415.717528474157;7724.6910123594425;7954.448882467979;7966.362690984707;8015.519068855887;8030.638621262174;7622.237776222333;7626.885596716164;7725.5364678119495;7743.6515356810205;7760.14638389788;9033.774155645899;9193.402428842104;9264.72205833826;9265.629374824932;9431.339806213498;8904.421212621159;9185.632574696938;9342.065793420876;9470.242380609672;9490.050994900455;7097.680604372712;7688.423368247516;7769.8834517481155;7868.685252589832;7897.131315555399;8005;8014.919850801417;8050.436469447082;8062.234087761653;8070.394720395876;7080.114985626797;7254.45591580623;7297.598632075074;7363.079615048119;7428.071491063617;6882.105326307548;7010.053642758162;7141.964290178724;7151.463640227108;7220.602866842374;7468.4398670101045;7534.962325188339;7535.8116047099265;7542.094948606203;7542.773716788505;7007.159140903124;7063.470239732143;7083.468739844635;7090.042844216171;7102.715891364288;6981.162260528769;7121.074260346122;7176.282371762782;7178.5692858428665;7203.675834587351 12:06:24 INFO - PROCESS | 7116 | |4;prototype.html;296.31698933957233;316.24102154828415;319.3214419358864;322;326.26752939650487;5715.57133215009;5807.506361959238;5874.500667443262;5901.881962360751;5914.2311499505;5780.971095144519;5801.82594522165;5814.592978491507;5817.476427121558;5822.883542329151;4263.4883813942215;4322.113966636847;4397.582229688191;4452.621527170187;4459.866204013885;4427.71219870709;4452.97773511132;4464.196444639963;4464.6428285737065;4476.171908196978;4408.074304396081;4408.647308215335;4411.602955733983;4423.889402764925;4430.86707398777;4237.067845074094;4299.204647140274;4387.078713470175;4391.385206071152;4401.735895846227;3855.4987851579394;3860.1893602343544;3860.7876566788814;3862.2661694278277;3870.283997460451;5590.217369568264;5620.5503559715125;5624.578156638268;5633.6619802811965;5636.520895723868;5143.074246635604;5144.459831717653;5151.871203219912;5152.046871328816;5155.793768249266;6046.425589568984;6071.848203794896;6097.817065488042;6097.817065488042;6104.542159338067;4193.580641935782;4272.081502476951;4284.314509678467;4293.527711951683;4304.741715497049;6321.431071203568;6380.234371875358;6381.298057213657;6382.680865956683;6384.553081284312;4366.6506679465565;4375.965176193085;4377.868663940087;4377.934330985037;4380.824767009284;4449.510553839075;4452.5992660660695;4455.4876189238;4459.308807134835;4461.933071003938;5131.5638170755155;5135.6148288878485;5138.486151384906;5144.948550514522;5147.0735267651435;6012.428819262163;6120.938790612036;6136.447719705248;6159.4456498915315;6166.075088736636;1529.3576697786957;1569.8979566328153;1572.559683288681;1573.0954701046944;1575.220265968353;968.8837339519162;1026.8333815649123;1044.2064031336088;1049.7375656085978;1050.201846596592;5881.794137205177;5883.558733095035;5892.145638882338;5893.263342082239;5919.6744179070565;6322.589031713016;6327.651979141099;6328.050792381087;6336.714847831767;6338.714757835908;5923.940760592339;5925.377835327315;5939.287285525678;5944.613600115978;5950.285965684146;3353.2790450052867;3390.69483746464;3397.1676939150066;3397.558317418769;3397.7451691123265;6350.396712312323;6436.16329877113;6484;6505.154329937078;6525.184351956005;6414.550981431348;6426.196725409324;6441.291457939623;6447.419732224029;6451.774187903401;6497.772577959749;6533.738650454024;6571.112899758471;6582.0785090086465;6586.27550969393;6300.495960323255;6310.368963103653;6316.873662526816;6325.1144839721555;6330.905036424365;6103;6220.782272620437;6227.097070924781;6228.56400051992;6234.129761071751;6525.347465253437;6578.934210658023;6590.505712071518;6592.868142637216;6600.108985287116;4319.11458151072;4352.303631418958;4357.716748411343;4358.978205108954;4360.280553708602;6371.203599550056;6384.361563843579;6390.584612000205;6392.105105285171;6394.6482943436695;6220.720067596879;6222.782202622887;6226.906596400967;6227.532935029982;6230.968845155745;6008.669523176267;6158.137860699595;6173.753049877954;6189.257289125334;6209.223847019122;6049.485793707408;6086.117512960507;6088.056351265561;6103.938960610337;6110.847228819315;6241.625502469867;6246.843828904313;6266.592671476339;6301.590396624205;6316.3367846377305;5811.360750317546;5911.113332999912;6074.665893375906;6075.544334175043;6087.208662873798 12:06:24 INFO - PROCESS | 7116 | |5;yui.html;734.8493558820443;746.7199800074972;759.1232126893436;785.395245660841;786.5162924801249;13659.521916732916;13891.930540347284;13915.512957046505;13916.791248131287;14011.229382383952;14734.379218286007;14834;14914.254287285647;15011.849881501183;15043.17262550562;658.2331583704978;799.7680672604952;803.6865622407266;805.8589746794288;813.9918600814004;812.9430939834214;821.5070957425556;821.9013718353776;823.1110400767187;824.1346586084617;853.2150421612132;853.7353420439683;853.9871901921476;854;854.3165467625905;696.1089805049545;854.1202561361777;858.2576071697968;868.0538213347481;870.6647940542873;626.6835248199676;627.704978660029;629.6599836088507;629.7260691599123;629.8079085878805;13836.792448113287;13930.86069139316;13934.303284835718;13937.512187073506;13940.721185576333;13015.479380824756;13074.15018023835;13274.137181083199;13407.932960335136;13459.461621535127;10533.84199237012;10628.309159904658;10666.733331666694;10846.620368287151;10905.563777448893;3726.4037753959506;3747.7189210809024;3790.4882840816413;3862.5944275851193;3892.2215556888737;51959.32366087032;52577.47422525764;52688.20967685488;52858.207126893125;53629.46370536284;10649.627263045757;10665.306755060896;10666.093382062612;10667;10819.729506762395;18552.257909683733;18574.535636609195;18586;18688.159032843556;18968.43926069963;8394.706185283485;8437.535935523483;8624.870626940601;8646.481211127353;8654.35092368075;4880.145974454456;4949.90100197994;4955.752212389366;4956.10790057793;4971.37857767779;3268.8038717677014;3269.182704323919;3286.244163842282;3296.340731853591;3300.66993300668;604.9274087109487;610.9175261339751;613.6962203709193;616.6280026940022;622.9969748704582;682.6791408038214;715.2489885620079;729.6461216310191;737.2664199121801;739.5969196787763;9613.615455381847;9659.806803863883;9697;9795.291962672429;9922.900770992197;603.7072020070262;692.4737199728243;717.4736171716062;726.072278101641;749.6514120933683;4430.424044874146;4490.371348011281;4551.52209018055;4551.908961820745;4620.376249206314;62473.68763156155;62536.74926501536;62671.37328626656;63284.36715632877;64971;51520.48479515157;52190;52457.7377113112;53285;53321.2001819973;48674.513254867;48752.512474875504;48774.756126219145;48993.510064898896;49083.80955237898;9845.113939745457;9901.455419951972;9926.801463970536;9966.601335946481;10061.849072263776;34541.82729086339;36544.81727591345;37485.576130556365;37562.436563451025;38016.239675206896;45114;45183.32225016693;45801;47459.76270118627;47872.760636196595;11076;11085.334879907232;11278.436078196222;11546.42267886619;11823.881761182278;12292.692682683004;13190.34048297562;13318.334083295602;13398.397072131582;13496.86503134956;10675.839862401916;10971.835422468828;11462.254953428;12223.327716975296;12894.742105158031;12517.56188533397;12651.367431628198;12842.101052926206;13333.533326333532;13459.461621535029;11944.522219111486;12584.937075314565;12689.806393740664;12813.359332033548;12819.359032048547;10124.746881328027;10567.894321056998;10606;10961.068309193808;10998.945005274922;10046.196304295492;10218.437985910847;10288.948555257175;10294.227932905213;10315.535800889129 12:06:24 INFO - PROCESS | 7116 | __end_tp_report 12:06:24 INFO - PROCESS | 7116 | __start_cc_report 12:06:24 INFO - PROCESS | 7116 | _x_x_mozilla_cycle_collect,796 12:06:24 INFO - PROCESS | 7116 | __end_cc_report 12:06:24 INFO - PROCESS | 7116 | __startTimestamp1458932784580__endTimestamp 12:06:24 INFO - PROCESS | 7116 | 12:06:24 INFO - PROCESS | 7116 | ------- Summary: start ------- 12:06:24 INFO - PROCESS | 7116 | Number of tests: 6 12:06:24 INFO - PROCESS | 7116 | 12:06:24 INFO - PROCESS | 7116 | [#0] dojo.html Cycles:165 Average:5223.07 Median:5464.67 stddev:589.85 (10.8%) stddev-sans-first:565.64 12:06:24 INFO - PROCESS | 7116 | Values: 3014.7 3063.6 3105.9 3107.1 3132.3 5112.1 5251.0 5251.1 5279.2 5288.9 5267.7 5283.4 5292.0 5307.4 5321.3 4651.2 4684.9 4791.1 4795.8 4837.0 4659.1 4777.4 4788.7 4811.0 4826.4 4722.0 4745.3 4761.5 4763.4 4798.1 4792.0 4795.7 4803.9 4805.5 4808.3 4623.3 4691.7 4775.0 4783.1 4810.3 5199.2 5202.2 5222.9 5236.3 5240.2 5622.5 5656.6 5658.5 5662.7 5670.4 5478.7 5696.9 5714.6 5774.9 5787.6 5223.8 5230.8 5236.4 5236.6 5239.8 5708.3 5714.3 5715.1 5716.1 5720.3 5426.1 5474.3 5486.6 5526.5 5531.7 5648.9 5665.7 5678.3 5679.8 5683.7 5520.1 5618.3 5634.1 5646.3 5649.1 5471.1 5518.8 5526.6 5541.8 5566.2 4289.9 4290.0 4301.2 4301.6 4343.9 3759.3 3801.4 3849.5 3871.7 3879.6 5306.1 5332.5 5351.8 5376.1 5377.4 5577.7 5604.9 5633.4 5647.0 5649.1 5202.7 5288.0 5290.0 5296.0 5335.5 4812.6 4850.7 4850.7 4855.1 4898.7 5676.3 5706.5 5709.8 5714.3 5769.5 5514.3 5609.5 5617.4 5639.6 5744.1 5805.9 5812.6 5818.3 5821.3 5828.0 5570.2 5583.7 5591.0 5596.5 5598.4 5563.4 5629.9 5647.5 5721.8 5733.6 5533.4 5540.4 5540.8 5541.0 5544.1 5498.4 5504.8 5505.0 5509.8 5512.2 5269.2 5370.8 5444.6 5462.0 5478.9 5539.3 5556.7 5566.7 5570.3 5580.7 5358.1 5447.4 5464.7 5468.6 5512.3 12:06:24 INFO - PROCESS | 7116 | 12:06:24 INFO - PROCESS | 7116 | [#1] ext.html Cycles:180 Average:60154.82 Median:37745.03 stddev:132665.97 (351.5%) stddev-sans-first:132962.65 12:06:24 INFO - PROCESS | 7116 | Values: 550.9 573.6 578.8 591.1 610.7 30259.7 30295.7 30340.7 30362.1 38289.2 40259.0 40772.6 40789.6 40796.6 40959.8 8547.1 8750.4 8750.9 8762.1 8768.0 8618.1 8679.0 8716.9 8771.2 8792.2 8723.5 8768.6 8771.2 8795.8 8948.9 8867.5 8920.5 8927.3 8938.4 8948.6 8813.3 8903.8 8945.6 8947.6 8951.8 41460.4 41648.4 41709.0 41844.4 41868.8 3485.5 3596.0 3653.4 3655.3 3675.5 29829.0 30072.2 30218.7 30278.8 30615.6 4288.8 4331.5 4399.2 4410.3 4461.4 309436.0 314999.0 315658.0 315875.0 316217.0 58317.4 65997.3 66795.7 66906.0 67009.7 71999.0 72809.0 72836.3 72899.3 72960.6 16703.8 16705.8 16836.2 16939.7 16954.2 12459.8 12735.3 12979.9 13092.9 13100.5 21382.6 21860.0 21934.1 21962.2 21970.5 7547.5 7965.4 8053.2 8539.6 8583.6 945.1 1015.4 1015.7 1044.8 1174.9 29776.6 29853.0 29915.9 30452.5 30477.1 1097.7 1114.9 1131.9 1173.4 1191.7 15876.4 16419.1 16443.5 16665.3 16690.0 416165.0 785224.0 797066.0 798229.0 799180.0 58582.7 59028.4 59394.7 59401.7 59470.7 1192.1 1301.3 1377.1 1406.9 1423.7 29360.4 30401.5 30633.2 30841.4 32930.8 46590.0 47121.0 47169.8 47191.8 47217.3 295583.0 295813.0 296297.0 296794.0 296853.0 32492.4 36418.8 36423.8 36691.3 36813.6 42827.7 44213.0 44426.1 45137.0 45186.1 37372.8 37391.3 37519.1 37663.2 38035.8 37115.8 37161.4 37667.0 37750.0 37896.8 37740.1 38139.6 38240.8 38788.4 38927.0 33004.2 33592.7 34041.5 34137.0 34236.7 25648.6 25992.2 26322.9 27451.9 27803.9 12:06:24 INFO - PROCESS | 7116 | 12:06:24 INFO - PROCESS | 7116 | [#2] jquery.html Cycles:180 Average:28411.16 Median:2711.99 stddev:89704.08 (3307.7%) stddev-sans-first:89930.98 12:06:24 INFO - PROCESS | 7116 | Values: 355.3 360.0 362.8 368.9 369.7 17051.4 17161.0 18201.3 18223.7 18227.4 15300.8 15771.3 15804.0 15806.9 15815.8 4904.5 5359.9 5662.3 5662.6 5666.9 4106.7 6029.0 6230.6 6253.5 6261.4 5920.3 6185.2 6187.9 6214.6 6218.7 5970.6 5972.5 5990.5 5997.0 6010.2 3654.1 3781.7 5261.5 5437.5 5450.8 19804.4 19832.0 19874.8 20221.8 20237.5 2317.3 2335.1 2447.3 2976.7 3060.0 12939.9 13014.6 13180.3 13212.0 13439.3 1891.6 1919.8 1992.2 2009.1 2024.1 63792.7 65632.0 66388.0 67090.0 68550.0 9217.8 9248.5 9261.9 9359.7 9549.0 12173.8 12253.0 12260.2 12266.0 12338.9 7455.2 7481.9 7555.4 7635.7 7778.4 7675.5 7770.7 7775.6 7880.6 7912.1 5697.5 5704.6 5716.5 5750.0 5802.6 1567.6 1694.3 1795.0 1809.2 1845.3 995.2 1009.3 1031.8 1042.5 1074.7 17258.6 17436.6 17463.9 17905.5 18322.1 1009.4 1016.9 1042.1 1077.4 1111.7 10156.8 10546.2 10566.3 10574.4 10575.5 518048.0 539620.0 553881.0 558241.0 573598.0 69883.0 72199.3 72554.6 72946.3 73051.6 1080.6 1088.3 1104.9 1120.9 1121.6 16221.0 16293.3 16356.4 16443.6 16563.2 22019.8 22508.0 32411.2 33470.3 35549.5 46178.5 46451.8 46718.8 46814.3 47188.0 7531.6 7733.7 7743.7 7836.9 7915.3 6675.7 8129.7 8877.7 11292.0 11691.1 10755.2 10928.3 10995.8 11010.1 11165.2 10483.1 10619.9 10767.5 11178.8 11371.4 10770.8 11004.8 11185.1 11193.0 11466.0 7307.1 7317.0 7490.6 7599.4 7611.0 10391.9 10475.8 10483.9 10493.3 10587.8 12:06:24 INFO - PROCESS | 7116 | 12:06:24 INFO - PROCESS | 7116 | [#3] mootools.html Cycles:180 Average:5762.56 Median:6931.63 stddev:2957.01 (42.7%) stddev-sans-first:2946.90 12:06:24 INFO - PROCESS | 7116 | Values: 1373.8 1496.2 1509.2 1663.6 1793.7 7904.9 8085.9 8089.2 8097.4 8106.0 7744.8 7890.5 7895.6 7900.0 7910.6 2002.5 2047.3 2240.6 2252.9 2268.9 2283.3 2284.3 2291.8 2298.7 2302.8 2224.9 2247.6 2337.7 2338.7 2339.1 2270.8 2299.0 2307.4 2327.8 2329.0 2243.4 2257.7 2261.0 2265.9 2268.4 8252.1 8293.5 8307.4 8310.1 8312.6 4916.0 5071.7 5074.4 5076.1 5077.8 3256.6 3335.9 3396.1 3406.0 3426.5 1163.2 1163.5 1174.7 1198.6 1199.9 10649.7 10695.5 10761.8 10764.1 10778.8 4287.3 4383.1 4412.1 4457.0 4462.7 9267.8 9289.7 9343.8 9363.0 9370.1 4923.0 4945.0 4948.8 4950.0 4958.9 4110.6 4607.9 4660.0 4685.2 4702.2 3736.8 3821.8 3824.1 3847.8 3877.4 1202.9 1222.4 1224.0 1231.2 1231.3 1390.9 1402.7 1420.6 1431.1 1437.3 7994.5 8205.4 8220.5 8224.7 8229.3 1057.4 1143.6 1145.6 1150.8 1154.7 6345.3 6371.5 6406.2 6417.1 6431.9 9159.6 9305.4 9414.1 9420.0 9448.8 9223.8 9356.9 9361.7 9372.3 9415.7 7724.7 7954.4 7966.4 8015.5 8030.6 7622.2 7626.9 7725.5 7743.7 7760.1 9033.8 9193.4 9264.7 9265.6 9431.3 8904.4 9185.6 9342.1 9470.2 9490.1 7097.7 7688.4 7769.9 7868.7 7897.1 8005.0 8014.9 8050.4 8062.2 8070.4 7080.1 7254.5 7297.6 7363.1 7428.1 6882.1 7010.1 7142.0 7151.5 7220.6 7468.4 7535.0 7535.8 7542.1 7542.8 7007.2 7063.5 7083.5 7090.0 7102.7 6981.2 7121.1 7176.3 7178.6 7203.7 12:06:24 INFO - PROCESS | 7116 | 12:06:24 INFO - PROCESS | 7116 | [#4] prototype.html Cycles:180 Average:5143.36 Median:5892.70 stddev:1551.53 (26.3%) stddev-sans-first:1512.63 12:06:24 INFO - PROCESS | 7116 | Values: 296.3 316.2 319.3 322.0 326.3 5715.6 5807.5 5874.5 5901.9 5914.2 5781.0 5801.8 5814.6 5817.5 5822.9 4263.5 4322.1 4397.6 4452.6 4459.9 4427.7 4453.0 4464.2 4464.6 4476.2 4408.1 4408.6 4411.6 4423.9 4430.9 4237.1 4299.2 4387.1 4391.4 4401.7 3855.5 3860.2 3860.8 3862.3 3870.3 5590.2 5620.6 5624.6 5633.7 5636.5 5143.1 5144.5 5151.9 5152.0 5155.8 6046.4 6071.8 6097.8 6097.8 6104.5 4193.6 4272.1 4284.3 4293.5 4304.7 6321.4 6380.2 6381.3 6382.7 6384.6 4366.7 4376.0 4377.9 4377.9 4380.8 4449.5 4452.6 4455.5 4459.3 4461.9 5131.6 5135.6 5138.5 5144.9 5147.1 6012.4 6120.9 6136.4 6159.4 6166.1 1529.4 1569.9 1572.6 1573.1 1575.2 968.9 1026.8 1044.2 1049.7 1050.2 5881.8 5883.6 5892.1 5893.3 5919.7 6322.6 6327.7 6328.1 6336.7 6338.7 5923.9 5925.4 5939.3 5944.6 5950.3 3353.3 3390.7 3397.2 3397.6 3397.7 6350.4 6436.2 6484.0 6505.2 6525.2 6414.6 6426.2 6441.3 6447.4 6451.8 6497.8 6533.7 6571.1 6582.1 6586.3 6300.5 6310.4 6316.9 6325.1 6330.9 6103.0 6220.8 6227.1 6228.6 6234.1 6525.3 6578.9 6590.5 6592.9 6600.1 4319.1 4352.3 4357.7 4359.0 4360.3 6371.2 6384.4 6390.6 6392.1 6394.6 6220.7 6222.8 6226.9 6227.5 6231.0 6008.7 6158.1 6173.8 6189.3 6209.2 6049.5 6086.1 6088.1 6103.9 6110.8 6241.6 6246.8 6266.6 6301.6 6316.3 5811.4 5911.1 6074.7 6075.5 6087.2 12:06:24 INFO - PROCESS | 7116 | 12:06:24 INFO - PROCESS | 7116 | [#5] yui.html Cycles:180 Average:14737.38 Median:4551.72 stddev:16957.69 (372.6%) stddev-sans-first:16972.66 12:06:24 INFO - PROCESS | 7116 | Values: 734.8 746.7 759.1 785.4 786.5 13659.5 13891.9 13915.5 13916.8 14011.2 14734.4 14834.0 14914.3 15011.8 15043.2 658.2 799.8 803.7 805.9 814.0 812.9 821.5 821.9 823.1 824.1 853.2 853.7 854.0 854.0 854.3 696.1 854.1 858.3 868.1 870.7 626.7 627.7 629.7 629.7 629.8 13836.8 13930.9 13934.3 13937.5 13940.7 13015.5 13074.2 13274.1 13407.9 13459.5 10533.8 10628.3 10666.7 10846.6 10905.6 3726.4 3747.7 3790.5 3862.6 3892.2 51959.3 52577.5 52688.2 52858.2 53629.5 10649.6 10665.3 10666.1 10667.0 10819.7 18552.3 18574.5 18586.0 18688.2 18968.4 8394.7 8437.5 8624.9 8646.5 8654.4 4880.1 4949.9 4955.8 4956.1 4971.4 3268.8 3269.2 3286.2 3296.3 3300.7 604.9 610.9 613.7 616.6 623.0 682.7 715.2 729.6 737.3 739.6 9613.6 9659.8 9697.0 9795.3 9922.9 603.7 692.5 717.5 726.1 749.7 4430.4 4490.4 4551.5 4551.9 4620.4 62473.7 62536.7 62671.4 63284.4 64971.0 51520.5 52190.0 52457.7 53285.0 53321.2 48674.5 48752.5 48774.8 48993.5 49083.8 9845.1 9901.5 9926.8 9966.6 10061.8 34541.8 36544.8 37485.6 37562.4 38016.2 45114.0 45183.3 45801.0 47459.8 47872.8 11076.0 11085.3 11278.4 11546.4 11823.9 12292.7 13190.3 13318.3 13398.4 13496.9 10675.8 10971.8 11462.3 12223.3 12894.7 12517.6 12651.4 12842.1 13333.5 13459.5 11944.5 12584.9 12689.8 12813.4 12819.4 10124.7 10567.9 10606.0 10961.1 10998.9 10046.2 10218.4 10288.9 10294.2 10315.5 12:06:24 INFO - PROCESS | 7116 | -------- Summary: end -------- 12:06:24 INFO - PROCESS | 7116 | 12:06:25 INFO - TEST-INFO | 7116: exit 0 12:06:25 INFO - TEST-OK | dromaeo_css | took 1111860ms 12:06:25 INFO - TEST-START | kraken 12:06:25 INFO - operating with platform_type : linux_ 12:06:25 INFO - Initialising browser for kraken test... 12:06:25 INFO - TEST-INFO | started process 7302 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdTTSJB/profile http://localhost:48486/getInfo.html) 12:06:29 INFO - PROCESS | 7302 | __metrics Screen width/height:1600/1200 12:06:29 INFO - PROCESS | 7302 | colorDepth:24 12:06:29 INFO - PROCESS | 7302 | Browser inner width/height: 1024/697 12:06:29 INFO - PROCESS | 7302 | __metrics 12:06:30 ERROR - PROCESS | 7302 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:06:31 INFO - TEST-INFO | 7302: exit 0 12:06:31 INFO - Browser initialized. 12:06:31 INFO - Running cycle 1/1 for kraken test... 12:06:31 INFO - TEST-INFO | started process 7391 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdTTSJB/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:06:43 INFO - PROCESS | 7391 | RSS: Main: 153104384 12:06:43 INFO - PROCESS | 7391 | 12:06:45 INFO - PROCESS | 7391 | Cycle 1(1): loaded http://localhost:48486/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48486/tests/kraken/driver.html?testName=audio-beat-detection) 12:06:46 INFO - PROCESS | 7391 | RSS: Main: 194863104 12:06:46 INFO - PROCESS | 7391 | 12:06:48 INFO - PROCESS | 7391 | Cycle 1(1): loaded http://localhost:48486/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48486/tests/kraken/driver.html?testName=audio-dft) 12:06:49 INFO - PROCESS | 7391 | RSS: Main: 184320000 12:06:49 INFO - PROCESS | 7391 | 12:06:52 INFO - PROCESS | 7391 | Cycle 1(1): loaded http://localhost:48486/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48486/tests/kraken/driver.html?testName=audio-fft) 12:06:52 INFO - PROCESS | 7391 | RSS: Main: 169738240 12:06:52 INFO - PROCESS | 7391 | 12:06:54 INFO - PROCESS | 7391 | Cycle 1(1): loaded http://localhost:48486/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48486/tests/kraken/driver.html?testName=audio-oscillator) 12:06:55 INFO - PROCESS | 7391 | RSS: Main: 171307008 12:06:55 INFO - PROCESS | 7391 | 12:06:57 INFO - PROCESS | 7391 | Cycle 1(1): loaded http://localhost:48486/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48486/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:06:58 INFO - PROCESS | 7391 | RSS: Main: 172589056 12:06:58 INFO - PROCESS | 7391 | 12:07:01 INFO - PROCESS | 7391 | Cycle 1(1): loaded http://localhost:48486/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48486/tests/kraken/driver.html?testName=imaging-darkroom) 12:07:01 INFO - PROCESS | 7391 | RSS: Main: 173133824 12:07:01 INFO - PROCESS | 7391 | 12:07:05 INFO - PROCESS | 7391 | Cycle 1(1): loaded http://localhost:48486/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48486/tests/kraken/driver.html?testName=imaging-desaturate) 12:07:05 INFO - PROCESS | 7391 | RSS: Main: 172683264 12:07:05 INFO - PROCESS | 7391 | 12:07:08 INFO - PROCESS | 7391 | Cycle 1(1): loaded http://localhost:48486/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48486/tests/kraken/driver.html?testName=json-parse-financial) 12:07:09 INFO - PROCESS | 7391 | RSS: Main: 173330432 12:07:09 INFO - PROCESS | 7391 | 12:07:10 INFO - PROCESS | 7391 | Cycle 1(1): loaded http://localhost:48486/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48486/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:07:11 INFO - PROCESS | 7391 | RSS: Main: 183885824 12:07:11 INFO - PROCESS | 7391 | 12:07:13 INFO - PROCESS | 7391 | Cycle 1(1): loaded http://localhost:48486/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48486/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:07:13 INFO - PROCESS | 7391 | RSS: Main: 181997568 12:07:13 INFO - PROCESS | 7391 | 12:07:15 INFO - PROCESS | 7391 | Cycle 1(1): loaded http://localhost:48486/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48486/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:07:16 INFO - PROCESS | 7391 | RSS: Main: 192819200 12:07:16 INFO - PROCESS | 7391 | 12:07:18 INFO - PROCESS | 7391 | Cycle 1(1): loaded http://localhost:48486/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48486/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:07:19 INFO - PROCESS | 7391 | RSS: Main: 198778880 12:07:19 INFO - PROCESS | 7391 | 12:07:21 INFO - PROCESS | 7391 | Cycle 1(1): loaded http://localhost:48486/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48486/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:07:22 INFO - PROCESS | 7391 | RSS: Main: 196722688 12:07:22 INFO - PROCESS | 7391 | 12:07:24 INFO - PROCESS | 7391 | Cycle 1(1): loaded http://localhost:48486/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48486/tests/kraken/driver.html?testName=ai-astar) 12:07:24 INFO - PROCESS | 7391 | RSS: Main: 259006464 12:07:24 INFO - PROCESS | 7391 | 12:07:24 INFO - PROCESS | 7391 | __start_tp_report 12:07:24 INFO - PROCESS | 7391 | _x_x_mozilla_page_load 12:07:24 INFO - PROCESS | 7391 | _x_x_mozilla_page_load_details 12:07:24 INFO - PROCESS | 7391 | |i|pagename|runs| 12:07:24 INFO - PROCESS | 7391 | |0;ai-astar;109;110;106;109;109;110;99;111;109;110 12:07:24 INFO - PROCESS | 7391 | |1;audio-beat-detection;151;127;159;171;135;158;160;130;173;128 12:07:24 INFO - PROCESS | 7391 | |2;audio-dft;164;161;161;160;160;160;160;163;161;161 12:07:24 INFO - PROCESS | 7391 | |3;audio-fft;76;78;105;112;76;73;76;123;102;77 12:07:24 INFO - PROCESS | 7391 | |4;audio-oscillator;92;94;150;93;94;92;137;93;92;146 12:07:24 INFO - PROCESS | 7391 | |5;imaging-gaussian-blur;117;117;117;117;117;116;118;117;117;117 12:07:24 INFO - PROCESS | 7391 | |6;imaging-darkroom;146;147;146;146;146;148;146;146;145;147 12:07:24 INFO - PROCESS | 7391 | |7;imaging-desaturate;95;97;95;97;96;96;96;95;95;95 12:07:24 INFO - PROCESS | 7391 | |8;json-parse-financial;56;56;55;54;54;55;55;63;53;52 12:07:24 INFO - PROCESS | 7391 | |9;json-stringify-tinderbox;61;61;60;60;59;61;60;59;60;59 12:07:24 INFO - PROCESS | 7391 | |10;stanford-crypto-aes;79;78;79;86;79;78;81;77;87;79 12:07:24 INFO - PROCESS | 7391 | |11;stanford-crypto-ccm;111;113;117;120;120;111;120;123;108;119 12:07:24 INFO - PROCESS | 7391 | |12;stanford-crypto-pbkdf2;142;142;141;149;141;143;146;141;142;131 12:07:24 INFO - PROCESS | 7391 | |13;stanford-crypto-sha256-iterative;63;63;65;63;62;63;63;62;61;63 12:07:24 INFO - PROCESS | 7391 | __end_tp_report 12:07:24 INFO - PROCESS | 7391 | __start_cc_report 12:07:24 INFO - PROCESS | 7391 | _x_x_mozilla_cycle_collect,1069 12:07:24 INFO - PROCESS | 7391 | __end_cc_report 12:07:24 INFO - PROCESS | 7391 | __startTimestamp1458932844351__endTimestamp 12:07:24 INFO - PROCESS | 7391 | 12:07:24 INFO - PROCESS | 7391 | ------- Summary: start ------- 12:07:24 INFO - PROCESS | 7391 | Number of tests: 14 12:07:24 INFO - PROCESS | 7391 | 12:07:24 INFO - PROCESS | 7391 | [#0] ai-astar Cycles:10 Average:108.20 Median:110.00 stddev:3.49 (3.2%) stddev-sans-first:3.69 12:07:24 INFO - PROCESS | 7391 | Values: 109.0 110.0 106.0 109.0 109.0 110.0 99.0 111.0 109.0 110.0 12:07:24 INFO - PROCESS | 7391 | 12:07:24 INFO - PROCESS | 7391 | [#1] audio-beat-detection Cycles:10 Average:149.20 Median:158.50 stddev:17.79 (11.2%) stddev-sans-first:18.85 12:07:24 INFO - PROCESS | 7391 | Values: 151.0 127.0 159.0 171.0 135.0 158.0 160.0 130.0 173.0 128.0 12:07:24 INFO - PROCESS | 7391 | 12:07:24 INFO - PROCESS | 7391 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:1.37 (0.9%) stddev-sans-first:0.97 12:07:24 INFO - PROCESS | 7391 | Values: 164.0 161.0 161.0 160.0 160.0 160.0 160.0 163.0 161.0 161.0 12:07:24 INFO - PROCESS | 7391 | 12:07:24 INFO - PROCESS | 7391 | [#3] audio-fft Cycles:10 Average:89.80 Median:76.00 stddev:18.65 (24.5%) stddev-sans-first:19.10 12:07:24 INFO - PROCESS | 7391 | Values: 76.0 78.0 105.0 112.0 76.0 73.0 76.0 123.0 102.0 77.0 12:07:24 INFO - PROCESS | 7391 | 12:07:24 INFO - PROCESS | 7391 | [#4] audio-oscillator Cycles:10 Average:108.30 Median:92.50 stddev:25.07 (27.1%) stddev-sans-first:25.89 12:07:24 INFO - PROCESS | 7391 | Values: 92.0 94.0 150.0 93.0 94.0 92.0 137.0 93.0 92.0 146.0 12:07:24 INFO - PROCESS | 7391 | 12:07:24 INFO - PROCESS | 7391 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 12:07:24 INFO - PROCESS | 7391 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 118.0 117.0 117.0 117.0 12:07:24 INFO - PROCESS | 7391 | 12:07:24 INFO - PROCESS | 7391 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 12:07:24 INFO - PROCESS | 7391 | Values: 146.0 147.0 146.0 146.0 146.0 148.0 146.0 146.0 145.0 147.0 12:07:24 INFO - PROCESS | 7391 | 12:07:24 INFO - PROCESS | 7391 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.83 12:07:24 INFO - PROCESS | 7391 | Values: 95.0 97.0 95.0 97.0 96.0 96.0 96.0 95.0 95.0 95.0 12:07:24 INFO - PROCESS | 7391 | 12:07:24 INFO - PROCESS | 7391 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:55.00 stddev:2.98 (5.4%) stddev-sans-first:3.15 12:07:24 INFO - PROCESS | 7391 | Values: 56.0 56.0 55.0 54.0 54.0 55.0 55.0 63.0 53.0 52.0 12:07:24 INFO - PROCESS | 7391 | 12:07:24 INFO - PROCESS | 7391 | [#9] json-stringify-tinderbox Cycles:10 Average:60.00 Median:60.00 stddev:0.82 (1.4%) stddev-sans-first:0.78 12:07:24 INFO - PROCESS | 7391 | Values: 61.0 61.0 60.0 60.0 59.0 61.0 60.0 59.0 60.0 59.0 12:07:24 INFO - PROCESS | 7391 | 12:07:24 INFO - PROCESS | 7391 | [#10] stanford-crypto-aes Cycles:10 Average:80.30 Median:79.00 stddev:3.43 (4.3%) stddev-sans-first:3.61 12:07:24 INFO - PROCESS | 7391 | Values: 79.0 78.0 79.0 86.0 79.0 78.0 81.0 77.0 87.0 79.0 12:07:24 INFO - PROCESS | 7391 | 12:07:24 INFO - PROCESS | 7391 | [#11] stanford-crypto-ccm Cycles:10 Average:116.20 Median:119.50 stddev:5.05 (4.2%) stddev-sans-first:4.99 12:07:24 INFO - PROCESS | 7391 | Values: 111.0 113.0 117.0 120.0 120.0 111.0 120.0 123.0 108.0 119.0 12:07:24 INFO - PROCESS | 7391 | 12:07:24 INFO - PROCESS | 7391 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.80 Median:142.00 stddev:4.59 (3.2%) stddev-sans-first:4.87 12:07:24 INFO - PROCESS | 7391 | Values: 142.0 142.0 141.0 149.0 141.0 143.0 146.0 141.0 142.0 131.0 12:07:24 INFO - PROCESS | 7391 | 12:07:24 INFO - PROCESS | 7391 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.80 Median:63.00 stddev:1.03 (1.6%) stddev-sans-first:1.09 12:07:24 INFO - PROCESS | 7391 | Values: 63.0 63.0 65.0 63.0 62.0 63.0 63.0 62.0 61.0 63.0 12:07:24 INFO - PROCESS | 7391 | -------- Summary: end -------- 12:07:24 INFO - PROCESS | 7391 | 12:07:25 INFO - TEST-INFO | 7391: exit 0 12:07:25 INFO - TEST-OK | kraken | took 60096ms 12:07:25 INFO - SUITE-END | took 1171s 12:07:25 INFO - Completed test suite (00:19:32) 12:07:25 INFO - javascript benchmark 12:07:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3014.6985301469854, 3063.586415833862, 3105.9068227953153, 3107.0523490335454, 3132.3108916038473, 5112.105381558231, 5251.0, 5251.0810608143565, 5279.20811878218, 5288.867778305545, 5267.710275934822, 5283.418823929364, 5292.047431462335, 5307.363116426034, 5321.3348331458565, 4651.186042442576, 4684.929726054112, 4791.089692958327, 4795.832145874878, 4837.0, 4659.138059458994, 4777.402824646919, 4788.736619485927, 4810.951890481086, 4826.396700412449, 4721.952780472186, 4745.288206768978, 4761.4524329701835, 4763.404574428197, 4798.136335459616, 4792.041591681677, 4795.688280261772, 4803.927941080887, 4805.471398146201, 4808.2547205183255, 4623.260278355447, 4691.695039822401, 4775.0, 4783.115123702126, 4810.302506136591, 5199.194124910645, 5202.219667049935, 5222.8694282642855, 5236.319278493809, 5240.161574148156, 5622.465865742748, 5656.604037717361, 5658.547316214693, 5662.66024038559, 5670.376258611549, 5478.671279723229, 5696.943030569682, 5714.599978001542, 5774.913376299359, 5787.565932555033, 5223.791048358061, 5230.7969167091405, 5236.423993360727, 5236.633435659505, 5239.79040838366, 5708.31500219968, 5714.314282286069, 5715.057015592381, 5716.114002329646, 5720.313562372542, 5426.050441172779, 5474.288342515448, 5486.61593688438, 5526.47498487643, 5531.723413829292, 5648.85877853057, 5665.716714164275, 5678.346990096109, 5679.801206957736, 5683.687397193112, 5520.1443776214755, 5618.297712785902, 5634.126710359901, 5646.322441307069, 5649.12438572022, 5471.06991811393, 5518.779248830002, 5526.613137080366, 5541.750621222055, 5566.165075238666, 4289.935650965238, 4290.034742182984, 4301.161273551627, 4301.569843015736, 4343.9348409773875, 3759.3045286622064, 3801.3727734923427, 3849.4610754494392, 3871.690264778811, 3879.631435013669, 5306.071437498499, 5332.520073193431, 5351.785928562892, 5376.139817629239, 5377.435369286247, 5577.6653400796085, 5604.887902241932, 5633.436656334334, 5647.011772939719, 5649.067903795828, 5202.739863006835, 5288.021715982555, 5289.994900968803, 5295.973520132375, 5335.5464785492895, 4812.614990800797, 4850.684705494202, 4850.708957462563, 4855.101806165871, 4898.657094003385, 5676.318841739017, 5706.543476521868, 5709.8287051388525, 5714.314282286152, 5769.509591684669, 5514.338279406497, 5609.523190528851, 5617.43825617435, 5639.6334238274385, 5744.13837924298, 5805.912911306418, 5812.564057695605, 5818.301803783573, 5821.301443826768, 5828.0, 5570.2201691762375, 5583.692896890548, 5590.972045139748, 5596.496315331639, 5598.412166722598, 5563.388027317073, 5629.8592535186945, 5647.5481961442165, 5721.799737009184, 5733.598648094593, 5533.446655334435, 5540.36285827135, 5540.833774986757, 5541.030319694118, 5544.0575102231915, 5498.395176530658, 5504.752286147213, 5505.0, 5509.834704958857, 5512.200730894078, 5269.235960785742, 5370.785168593213, 5444.6188766785945, 5462.0441422751655, 5478.863028424321, 5539.335279766454, 5556.694381809039, 5566.749496272759, 5570.303712035996, 5580.665160090408, 5358.089124848863, 5447.428020057837, 5464.672119672832, 5468.562514998711, 5512.283403157724], "unit": "score", "name": "dojo.html", "value": 5183.6494557693895}, {"lowerIsBetter": false, "replicates": [550.8902866066596, 573.5927491481051, 578.7974209026842, 591.051362563086, 610.712964906494, 30259.69740302599, 30295.69704302959, 30340.696593034063, 30362.089137325915, 38289.23421531568, 40259.0, 40772.59227407725, 40789.59210407895, 40796.59203407965, 40959.795201024026, 8547.059823419419, 8750.431221970552, 8750.86873696895, 8762.079981601935, 8767.95616021919, 8618.138186181395, 8678.956605216965, 8716.912830871674, 8771.16673915977, 8792.208701216889, 8723.476591404537, 8768.649254029831, 8771.16673915977, 8795.78010549735, 8948.910510894873, 8867.467951922874, 8920.509371984539, 8927.33045021626, 8938.419002764833, 8948.552572371387, 8813.338999574993, 8903.777405564848, 8945.55272236392, 8947.64209431622, 8951.776205594848, 41460.37809432861, 41648.37527437091, 41709.0, 41844.372334415006, 41868.79065604653, 3485.4771784232316, 3595.9640403596154, 3653.3971894637352, 3655.2689462107683, 3675.5405574303213, 29829.0, 30072.248193795112, 30218.69781302181, 30278.84860575705, 30615.627348606664, 4288.785560721952, 4331.523532411432, 4399.1641588098155, 4410.316400957857, 4461.442319710036, 309436.0, 314999.0, 315658.0, 315875.0, 316217.0, 58317.41682583205, 65997.34002659912, 66795.65054368204, 66906.0, 67009.6649516759, 71999.0, 72808.99550524772, 72836.27163728295, 72899.27100728925, 72960.63519682367, 16703.83296167023, 16705.83294167067, 16836.158192090592, 16939.661206776043, 16954.23705933236, 12459.813102803466, 12735.29955852437, 12979.935100324627, 13092.869071309355, 13100.475980960846, 21382.572348553254, 21860.0, 21934.122635094736, 21962.231321903655, 21970.45073873134, 7547.471676982668, 7965.442419030728, 8053.1946805319, 8539.573021348908, 8583.613737381833, 945.1021529546958, 1015.3653966271081, 1015.7206768138673, 1044.7962647283707, 1174.8531433570804, 29776.553351699742, 29853.0, 29915.850420747756, 30452.54321185184, 30477.08568742941, 1097.7036200225893, 1114.8829372915889, 1131.9490622921987, 1173.3957012138756, 1191.7497325561728, 15876.44432444882, 16419.096949667644, 16443.506694799176, 16665.25006374716, 16690.0, 416165.0, 785224.0, 797066.0, 798229.0, 799180.0, 58582.707086464296, 59028.40971590315, 59394.703026485455, 59401.70299148563, 59470.702646487356, 1192.1476144556511, 1301.3298151452009, 1377.1048818268005, 1406.9226192559508, 1423.6583220027326, 29360.41279174447, 30401.543976840807, 30633.23416914595, 30841.42346560943, 32930.835345824074, 46590.0, 47121.0, 47169.76415117903, 47191.76404117957, 47217.291740624605, 295583.0, 295813.0, 296297.0, 296794.0, 296853.0, 32492.350152996336, 36418.8179059103, 36423.81788091043, 36691.26617467689, 36813.631863682094, 42827.73025661453, 44213.0, 44426.11147777091, 45137.0, 45186.09627807359, 37372.813135935234, 37391.25217495689, 37519.06202344963, 37663.246735065695, 38035.809820950715, 37115.81442092772, 37161.442578361886, 37667.0, 37750.0, 37896.81051594725, 37740.05649858776, 38139.61860381361, 38240.80879595584, 38788.41817372685, 38927.0, 33004.1748956278, 33592.656293747976, 34041.48937765886, 34137.0, 34236.657633424344, 25648.61527077058, 25992.22023339303, 26322.868385658716, 27451.862740686167, 27803.860980694968], "unit": "score", "name": "ext.html", "value": 19835.44713082294}, {"lowerIsBetter": false, "replicates": [355.25573922632094, 359.9992022178345, 362.77145398399006, 368.87273890507765, 369.65621971566446, 17051.403200887973, 17161.0, 18201.27194912202, 18223.726644100334, 18227.36204232852, 15300.770488442682, 15771.290291936863, 15804.0, 15806.920965395186, 15815.762763558527, 4904.509549045085, 5359.866003349908, 5662.263905692254, 5662.631928924628, 5666.914996275059, 4106.691998100139, 6028.969855150718, 6230.5950113242725, 6253.530985176108, 6261.405166509197, 5920.319163296233, 6185.195924529805, 6187.876242475148, 6214.5649804513705, 6218.657973811439, 5970.641761494303, 5972.522198224132, 5990.490808281302, 5997.040473524237, 6010.218671572711, 3654.14127679995, 3781.716371272166, 5261.500157485033, 5437.483439073281, 5450.809221677222, 19804.40586782399, 19832.0, 19874.80125198744, 20221.79778202214, 20237.49406264855, 2317.2584772872688, 2335.089315167086, 2447.278052974377, 2976.7023297670275, 3059.9809994677844, 12939.935300323532, 13014.609561713163, 13180.275084870329, 13212.0, 13439.26084065376, 1891.5649400637792, 1919.7504324437873, 1992.203118752496, 2009.1159889648654, 2024.0790440349606, 63792.681036594986, 65632.0, 66388.0, 67089.99365009577, 68550.0, 9217.815643687089, 9248.491332976751, 9261.907380926104, 9359.719208423758, 9549.0, 12173.817392739116, 12252.978258587233, 12260.203086799329, 12266.0, 12338.938305308595, 7455.217202193691, 7481.9251807482315, 7555.433342499335, 7635.656395462218, 7778.377729781717, 7675.53946763196, 7770.689172433153, 7775.5723435210475, 7880.64537095832, 7912.09010963735, 5697.4587414195585, 5704.572157088235, 5716.542676585863, 5749.9712501437225, 5802.622829516068, 1567.5689185474087, 1694.3392077089945, 1794.97307540387, 1809.2310767923843, 1845.317232623911, 995.1541189988452, 1009.2985375164337, 1031.8142734307746, 1042.5152304178594, 1074.7259448840496, 17258.568535786704, 17436.564085897953, 17463.912680436515, 17905.462836114937, 18322.083895805157, 1009.4094954451581, 1016.9186465082776, 1042.0985847242082, 1077.385890042668, 1111.6887271563976, 10156.796864062677, 10546.156307495383, 10566.31318964265, 10574.418406987535, 10575.524101415454, 518048.0, 539620.0, 553881.0, 558241.0, 573598.0, 69883.0, 72199.2780072203, 72554.63722681353, 72946.27053729501, 73051.63474182595, 1080.6001779341536, 1088.3034857691084, 1104.928179668319, 1120.882307357732, 1121.5513794482272, 16221.0, 16293.26680299413, 16356.427525036566, 16443.58891027734, 16563.171841407642, 22019.779802202414, 22508.0, 32411.18972025718, 33470.330593388484, 35549.466757999166, 46178.53821461877, 46451.76774116108, 46718.76640616911, 46814.297785532566, 47188.0, 7531.585762783099, 7733.729319473791, 7743.728969486041, 7836.882446763189, 7915.287624113857, 6675.7329706813125, 8129.67481300765, 8877.73366798997, 11292.0, 11691.123165762432, 10755.19336049815, 10928.289661171999, 10995.835062473909, 11010.119190464904, 11165.218434709492, 10483.056524912794, 10619.876024794918, 10767.461626918466, 11178.832317515407, 11371.43142842838, 10770.784584308427, 11004.834927475935, 11185.105191584491, 11193.0, 11466.0, 7307.123145222395, 7317.0487836580905, 7490.625468726651, 7599.392048636207, 7611.010568626265, 10391.948040259751, 10475.842862357224, 10483.947580262049, 10493.265471416928, 10587.841182382117], "unit": "score", "name": "jquery.html", "value": 8631.236451398689}, {"lowerIsBetter": false, "replicates": [1373.7733274009788, 1496.1845794042247, 1509.1774982634463, 1663.5508412728564, 1793.730940358946, 7904.881426778603, 8085.919140808597, 8089.231523005313, 8097.392695547843, 8106.0, 7744.767656970286, 7890.5265684058995, 7895.64469598868, 7899.960500197505, 7910.644021019054, 2002.519395345114, 2047.2834507922257, 2240.641497360423, 2252.9436764080865, 2268.875211863347, 2283.292179424384, 2284.2804516577226, 2291.8166546676307, 2298.747137814839, 2302.792748652621, 2224.8887555622237, 2247.5841969235744, 2337.6960995070704, 2338.672585837984, 2339.146211632759, 2270.7502174760843, 2299.022915261016, 2307.4231442139467, 2327.7788610082184, 2328.953420931589, 2243.4054975431523, 2257.661350797377, 2260.988695056514, 2265.886705664727, 2268.410213344526, 8252.133525979745, 8293.460925039853, 8307.376946728959, 8310.085890552094, 8312.625931833081, 4915.9754201229125, 5071.695698258116, 5074.416442109168, 5076.13705670037, 5077.796888124508, 3256.56036435083, 3335.8832440864694, 3396.100033491127, 3406.029281654741, 3426.5202871597994, 1163.168334640736, 1163.5055101581793, 1174.653477224221, 1198.5864876617552, 1199.8800119988018, 10649.733756656067, 10695.518701658522, 10761.784764304748, 10764.13886889047, 10778.838317425245, 4287.292596721506, 4383.057642606855, 4412.0955204183065, 4457.0, 4462.732236065846, 9267.76830579241, 9289.72130836076, 9343.766405839773, 9362.95318523403, 9370.062993700712, 4923.0, 4944.975275123601, 4948.802047918115, 4949.985253023122, 4958.851234462972, 4110.609492098246, 4607.8848028798875, 4660.04469083837, 4685.226937555333, 4702.15361234981, 3736.75711078779, 3821.808909554511, 3824.101336185994, 3847.8076096195077, 3877.360235561101, 1202.9097817663535, 1222.4315693202525, 1223.9632811015683, 1231.2181764579377, 1231.2735486063266, 1390.8551275364518, 1402.656349194454, 1420.595130387855, 1431.1270125223605, 1437.2669938331526, 7994.5203287802915, 8205.425620206648, 8220.465669731568, 8224.712135075244, 8229.341652667772, 1057.3655806516028, 1143.6397534776518, 1145.6448500964727, 1150.8216226484908, 1154.717094311899, 6345.270293916259, 6371.52213583983, 6406.167198264196, 6417.069524918954, 6431.903521447182, 9159.587818548182, 9305.441673499612, 9414.105659962293, 9419.952900235592, 9448.811023779623, 9223.815523689624, 9356.859647105299, 9361.719148425558, 9372.34393592442, 9415.717528474157, 7724.6910123594425, 7954.448882467979, 7966.362690984707, 8015.519068855887, 8030.638621262174, 7622.237776222333, 7626.885596716164, 7725.5364678119495, 7743.6515356810205, 7760.14638389788, 9033.774155645899, 9193.402428842104, 9264.72205833826, 9265.629374824932, 9431.339806213498, 8904.421212621159, 9185.632574696938, 9342.065793420876, 9470.242380609672, 9490.050994900455, 7097.680604372712, 7688.423368247516, 7769.8834517481155, 7868.685252589832, 7897.131315555399, 8005.0, 8014.919850801417, 8050.436469447082, 8062.234087761653, 8070.394720395876, 7080.114985626797, 7254.45591580623, 7297.598632075074, 7363.079615048119, 7428.071491063617, 6882.105326307548, 7010.053642758162, 7141.964290178724, 7151.463640227108, 7220.602866842374, 7468.4398670101045, 7534.962325188339, 7535.8116047099265, 7542.094948606203, 7542.773716788505, 7007.159140903124, 7063.470239732143, 7083.468739844635, 7090.042844216171, 7102.715891364288, 6981.162260528769, 7121.074260346122, 7176.282371762782, 7178.5692858428665, 7203.675834587351], "unit": "score", "name": "mootools.html", "value": 4738.261246638649}, {"lowerIsBetter": false, "replicates": [296.31698933957233, 316.24102154828415, 319.3214419358864, 322.0, 326.26752939650487, 5715.57133215009, 5807.506361959238, 5874.500667443262, 5901.881962360751, 5914.2311499505, 5780.971095144519, 5801.82594522165, 5814.592978491507, 5817.476427121558, 5822.883542329151, 4263.4883813942215, 4322.113966636847, 4397.582229688191, 4452.621527170187, 4459.866204013885, 4427.71219870709, 4452.97773511132, 4464.196444639963, 4464.6428285737065, 4476.171908196978, 4408.074304396081, 4408.647308215335, 4411.602955733983, 4423.889402764925, 4430.86707398777, 4237.067845074094, 4299.204647140274, 4387.078713470175, 4391.385206071152, 4401.735895846227, 3855.4987851579394, 3860.1893602343544, 3860.7876566788814, 3862.2661694278277, 3870.283997460451, 5590.217369568264, 5620.5503559715125, 5624.578156638268, 5633.6619802811965, 5636.520895723868, 5143.074246635604, 5144.459831717653, 5151.871203219912, 5152.046871328816, 5155.793768249266, 6046.425589568984, 6071.848203794896, 6097.817065488042, 6097.817065488042, 6104.542159338067, 4193.580641935782, 4272.081502476951, 4284.314509678467, 4293.527711951683, 4304.741715497049, 6321.431071203568, 6380.234371875358, 6381.298057213657, 6382.680865956683, 6384.553081284312, 4366.6506679465565, 4375.965176193085, 4377.868663940087, 4377.934330985037, 4380.824767009284, 4449.510553839075, 4452.5992660660695, 4455.4876189238, 4459.308807134835, 4461.933071003938, 5131.5638170755155, 5135.6148288878485, 5138.486151384906, 5144.948550514522, 5147.0735267651435, 6012.428819262163, 6120.938790612036, 6136.447719705248, 6159.4456498915315, 6166.075088736636, 1529.3576697786957, 1569.8979566328153, 1572.559683288681, 1573.0954701046944, 1575.220265968353, 968.8837339519162, 1026.8333815649123, 1044.2064031336088, 1049.7375656085978, 1050.201846596592, 5881.794137205177, 5883.558733095035, 5892.145638882338, 5893.263342082239, 5919.6744179070565, 6322.589031713016, 6327.651979141099, 6328.050792381087, 6336.714847831767, 6338.714757835908, 5923.940760592339, 5925.377835327315, 5939.287285525678, 5944.613600115978, 5950.285965684146, 3353.2790450052867, 3390.69483746464, 3397.1676939150066, 3397.558317418769, 3397.7451691123265, 6350.396712312323, 6436.16329877113, 6484.0, 6505.154329937078, 6525.184351956005, 6414.550981431348, 6426.196725409324, 6441.291457939623, 6447.419732224029, 6451.774187903401, 6497.772577959749, 6533.738650454024, 6571.112899758471, 6582.0785090086465, 6586.27550969393, 6300.495960323255, 6310.368963103653, 6316.873662526816, 6325.1144839721555, 6330.905036424365, 6103.0, 6220.782272620437, 6227.097070924781, 6228.56400051992, 6234.129761071751, 6525.347465253437, 6578.934210658023, 6590.505712071518, 6592.868142637216, 6600.108985287116, 4319.11458151072, 4352.303631418958, 4357.716748411343, 4358.978205108954, 4360.280553708602, 6371.203599550056, 6384.361563843579, 6390.584612000205, 6392.105105285171, 6394.6482943436695, 6220.720067596879, 6222.782202622887, 6226.906596400967, 6227.532935029982, 6230.968845155745, 6008.669523176267, 6158.137860699595, 6173.753049877954, 6189.257289125334, 6209.223847019122, 6049.485793707408, 6086.117512960507, 6088.056351265561, 6103.938960610337, 6110.847228819315, 6241.625502469867, 6246.843828904313, 6266.592671476339, 6301.590396624205, 6316.3367846377305, 5811.360750317546, 5911.113332999912, 6074.665893375906, 6075.544334175043, 6087.208662873798], "unit": "score", "name": "prototype.html", "value": 4633.881868147226}, {"lowerIsBetter": false, "replicates": [734.8493558820443, 746.7199800074972, 759.1232126893436, 785.395245660841, 786.5162924801249, 13659.521916732916, 13891.930540347284, 13915.512957046505, 13916.791248131287, 14011.229382383952, 14734.379218286007, 14834.0, 14914.254287285647, 15011.849881501183, 15043.17262550562, 658.2331583704978, 799.7680672604952, 803.6865622407266, 805.8589746794288, 813.9918600814004, 812.9430939834214, 821.5070957425556, 821.9013718353776, 823.1110400767187, 824.1346586084617, 853.2150421612132, 853.7353420439683, 853.9871901921476, 854.0, 854.3165467625905, 696.1089805049545, 854.1202561361777, 858.2576071697968, 868.0538213347481, 870.6647940542873, 626.6835248199676, 627.704978660029, 629.6599836088507, 629.7260691599123, 629.8079085878805, 13836.792448113287, 13930.86069139316, 13934.303284835718, 13937.512187073506, 13940.721185576333, 13015.479380824756, 13074.15018023835, 13274.137181083199, 13407.932960335136, 13459.461621535127, 10533.84199237012, 10628.309159904658, 10666.733331666694, 10846.620368287151, 10905.563777448893, 3726.4037753959506, 3747.7189210809024, 3790.4882840816413, 3862.5944275851193, 3892.2215556888737, 51959.32366087032, 52577.47422525764, 52688.20967685488, 52858.207126893125, 53629.46370536284, 10649.627263045757, 10665.306755060896, 10666.093382062612, 10667.0, 10819.729506762395, 18552.257909683733, 18574.535636609195, 18586.0, 18688.159032843556, 18968.43926069963, 8394.706185283485, 8437.535935523483, 8624.870626940601, 8646.481211127353, 8654.35092368075, 4880.145974454456, 4949.90100197994, 4955.752212389366, 4956.10790057793, 4971.37857767779, 3268.8038717677014, 3269.182704323919, 3286.244163842282, 3296.340731853591, 3300.66993300668, 604.9274087109487, 610.9175261339751, 613.6962203709193, 616.6280026940022, 622.9969748704582, 682.6791408038214, 715.2489885620079, 729.6461216310191, 737.2664199121801, 739.5969196787763, 9613.615455381847, 9659.806803863883, 9697.0, 9795.291962672429, 9922.900770992197, 603.7072020070262, 692.4737199728243, 717.4736171716062, 726.072278101641, 749.6514120933683, 4430.424044874146, 4490.371348011281, 4551.52209018055, 4551.908961820745, 4620.376249206314, 62473.68763156155, 62536.74926501536, 62671.37328626656, 63284.36715632877, 64971.0, 51520.48479515157, 52190.0, 52457.7377113112, 53285.0, 53321.2001819973, 48674.513254867, 48752.512474875504, 48774.756126219145, 48993.510064898896, 49083.80955237898, 9845.113939745457, 9901.455419951972, 9926.801463970536, 9966.601335946481, 10061.849072263776, 34541.82729086339, 36544.81727591345, 37485.576130556365, 37562.436563451025, 38016.239675206896, 45114.0, 45183.32225016693, 45801.0, 47459.76270118627, 47872.760636196595, 11076.0, 11085.334879907232, 11278.436078196222, 11546.42267886619, 11823.881761182278, 12292.692682683004, 13190.34048297562, 13318.334083295602, 13398.397072131582, 13496.86503134956, 10675.839862401916, 10971.835422468828, 11462.254953428, 12223.327716975296, 12894.742105158031, 12517.56188533397, 12651.367431628198, 12842.101052926206, 13333.533326333532, 13459.461621535029, 11944.522219111486, 12584.937075314565, 12689.806393740664, 12813.359332033548, 12819.359032048547, 10124.746881328027, 10567.894321056998, 10606.0, 10961.068309193808, 10998.945005274922, 10046.196304295492, 10218.437985910847, 10288.948555257175, 10294.227932905213, 10315.535800889129], "unit": "score", "name": "yui.html", "value": 6708.596728694991}], "name": "dromaeo_css", "value": 7124.117960317874}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 106.0, 109.0, 109.0, 110.0, 99.0, 111.0, 109.0, 110.0], "unit": "score", "name": "ai-astar", "value": 108.2}, {"lowerIsBetter": true, "replicates": [151.0, 127.0, 159.0, 171.0, 135.0, 158.0, 160.0, 130.0, 173.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 149.2}, {"lowerIsBetter": true, "replicates": [164.0, 161.0, 161.0, 160.0, 160.0, 160.0, 160.0, 163.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.1}, {"lowerIsBetter": true, "replicates": [76.0, 78.0, 105.0, 112.0, 76.0, 73.0, 76.0, 123.0, 102.0, 77.0], "unit": "score", "name": "audio-fft", "value": 89.8}, {"lowerIsBetter": true, "replicates": [92.0, 94.0, 150.0, 93.0, 94.0, 92.0, 137.0, 93.0, 92.0, 146.0], "unit": "score", "name": "audio-oscillator", "value": 108.3}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 118.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.0}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 148.0, 146.0, 146.0, 145.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.3}, {"lowerIsBetter": true, "replicates": [95.0, 97.0, 95.0, 97.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [56.0, 56.0, 55.0, 54.0, 54.0, 55.0, 55.0, 63.0, 53.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 55.3}, {"lowerIsBetter": true, "replicates": [61.0, 61.0, 60.0, 60.0, 59.0, 61.0, 60.0, 59.0, 60.0, 59.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 60.0}, {"lowerIsBetter": true, "replicates": [79.0, 78.0, 79.0, 86.0, 79.0, 78.0, 81.0, 77.0, 87.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.3}, {"lowerIsBetter": true, "replicates": [111.0, 113.0, 117.0, 120.0, 120.0, 111.0, 120.0, 123.0, 108.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.2}, {"lowerIsBetter": true, "replicates": [142.0, 142.0, 141.0, 149.0, 141.0, 143.0, 146.0, 141.0, 142.0, 131.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.8}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 65.0, 63.0, 62.0, 63.0, 63.0, 62.0, 61.0, 63.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 62.8}], "name": "kraken", "value": 1492.0}]} 12:07:25 INFO - Return code: 0 12:07:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 12:07:25 ERROR - # TBPL SUCCESS # 12:07:25 INFO - Running post-action listener: _resource_record_post_action 12:07:25 INFO - Running post-run listener: _resource_record_post_run 12:07:26 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 310145024; Read time: 0; Write time: 193328 12:07:26 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 20176896; Read time: 0; Write time: 6608 12:07:26 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 289513472; Read time: 0; Write time: 186688 12:07:26 INFO - Running post-run listener: _upload_blobber_files 12:07:26 INFO - Blob upload gear active. 12:07:26 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 12:07:26 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 12:07:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 12:07:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 12:07:27 INFO - (blobuploader) - INFO - Open directory for files ... 12:07:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 12:07:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:07:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:07:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:07:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:07:28 INFO - (blobuploader) - INFO - Done attempting. 12:07:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:07:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:07:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:07:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:07:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:07:28 INFO - (blobuploader) - INFO - Done attempting. 12:07:28 INFO - (blobuploader) - INFO - Iteration through files over. 12:07:28 INFO - Return code: 0 12:07:28 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 12:07:28 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 12:07:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/15f2db590ffd97b022852dca705236b9acd4cdd00b6cb53e071a257ae89c7129d0f5d5f10f0510469356b7ae2e9a7669ab69de22a98e36cb76eb7bb2990e5ad1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6f2eabf275fdb8e8cf5d723247e61b5e14bb4080d9677e4461602c4e1a2d26ff280b4ea996be58d4e07ba68344a8344de12eb20dabf1015a5c08e874c50ac900"} 12:07:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 12:07:28 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 12:07:28 INFO - Contents: 12:07:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/15f2db590ffd97b022852dca705236b9acd4cdd00b6cb53e071a257ae89c7129d0f5d5f10f0510469356b7ae2e9a7669ab69de22a98e36cb76eb7bb2990e5ad1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6f2eabf275fdb8e8cf5d723247e61b5e14bb4080d9677e4461602c4e1a2d26ff280b4ea996be58d4e07ba68344a8344de12eb20dabf1015a5c08e874c50ac900"} 12:07:28 INFO - Running post-run listener: copy_logs_to_upload_dir 12:07:28 INFO - Copying logs to upload dir... 12:07:28 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 12:07:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.366695 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-03-25 12:07:26.689700) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-25 12:07:26.693791) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1458929938.980286-947849827 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/15f2db590ffd97b022852dca705236b9acd4cdd00b6cb53e071a257ae89c7129d0f5d5f10f0510469356b7ae2e9a7669ab69de22a98e36cb76eb7bb2990e5ad1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6f2eabf275fdb8e8cf5d723247e61b5e14bb4080d9677e4461602c4e1a2d26ff280b4ea996be58d4e07ba68344a8344de12eb20dabf1015a5c08e874c50ac900"} build_url:https://queue.taskcluster.net/v1/task/TywIZsxwQtKWExtABuSh_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011252 build_url: 'https://queue.taskcluster.net/v1/task/TywIZsxwQtKWExtABuSh_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/15f2db590ffd97b022852dca705236b9acd4cdd00b6cb53e071a257ae89c7129d0f5d5f10f0510469356b7ae2e9a7669ab69de22a98e36cb76eb7bb2990e5ad1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6f2eabf275fdb8e8cf5d723247e61b5e14bb4080d9677e4461602c4e1a2d26ff280b4ea996be58d4e07ba68344a8344de12eb20dabf1015a5c08e874c50ac900"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-25 12:07:26.719301) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 12:07:26.719673) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1458929938.980286-947849827 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004437 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 12:07:26.805279) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-25 12:07:26.805601) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-25 12:07:26.805906) ========= ========= Total master_lag: 0.33 =========