builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-033 starttime: 1458054449.5 results: success (0) buildid: 20160315053010 builduid: 65a9775154fd41d78e133202fe258ba7 revision: c55260f518359813e95ac59b4af8b54f09946f49 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-15 08:07:29.496859) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-15 08:07:29.497323) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-15 08:07:29.497633) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=edae0fb5fee9fb758e8af6d3000002a4-1458054131.57783-1983725906 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006393 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.21 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-15 08:07:29.710040) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-15 08:07:29.710355) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-15 08:07:29.730166) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 08:07:29.730562) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=edae0fb5fee9fb758e8af6d3000002a4-1458054131.57783-1983725906 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.045807 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 08:07:29.787557) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-15 08:07:29.787873) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-15 08:07:29.788218) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 08:07:29.788490) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=edae0fb5fee9fb758e8af6d3000002a4-1458054131.57783-1983725906 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-15 08:07:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 66.1M=0s 2016-03-15 08:07:30 (66.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.342776 ========= master_lag: 0.20 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 08:07:30.331999) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 08:07:30.332328) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=edae0fb5fee9fb758e8af6d3000002a4-1458054131.57783-1983725906 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.128190 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 08:07:30.472066) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 08:07:30.472465) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c55260f518359813e95ac59b4af8b54f09946f49 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev c55260f518359813e95ac59b4af8b54f09946f49 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=edae0fb5fee9fb758e8af6d3000002a4-1458054131.57783-1983725906 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-15 08:07:30,510 truncating revision to first 12 chars 2016-03-15 08:07:30,510 Setting DEBUG logging. 2016-03-15 08:07:30,510 attempt 1/10 2016-03-15 08:07:30,510 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c55260f51835?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-15 08:07:30,777 unpacking tar archive at: fx-team-c55260f51835/testing/mozharness/ program finished with exit code 0 elapsedTime=0.547663 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 08:07:31.036369) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-15 08:07:31.036810) ========= echo c55260f518359813e95ac59b4af8b54f09946f49 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'c55260f518359813e95ac59b4af8b54f09946f49'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=edae0fb5fee9fb758e8af6d3000002a4-1458054131.57783-1983725906 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False c55260f518359813e95ac59b4af8b54f09946f49 program finished with exit code 0 elapsedTime=0.003416 script_repo_revision: 'c55260f518359813e95ac59b4af8b54f09946f49' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-15 08:07:31.085808) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-15 08:07:31.086127) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-15 08:07:31.096766) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 33 secs) (at 2016-03-15 08:07:31.097135) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=edae0fb5fee9fb758e8af6d3000002a4-1458054131.57783-1983725906 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:07:31 INFO - MultiFileLogger online at 20160315 08:07:31 in /builds/slave/test-pgo 08:07:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:07:31 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 08:07:31 INFO - {'append_to_log': False, 08:07:31 INFO - 'base_work_dir': '/builds/slave/test-pgo', 08:07:31 INFO - 'blob_upload_branch': 'Fx-Team', 08:07:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 08:07:31 INFO - 'branch': 'Fx-Team', 08:07:31 INFO - 'buildbot_json_path': 'buildprops.json', 08:07:31 INFO - 'config_files': ('talos/linux_config.py',), 08:07:31 INFO - 'default_actions': ('clobber', 08:07:31 INFO - 'read-buildbot-config', 08:07:31 INFO - 'download-and-extract', 08:07:31 INFO - 'populate-webroot', 08:07:31 INFO - 'create-virtualenv', 08:07:31 INFO - 'install', 08:07:31 INFO - 'run-tests'), 08:07:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:07:31 INFO - 'download_minidump_stackwalk': True, 08:07:31 INFO - 'download_symbols': 'ondemand', 08:07:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:07:31 INFO - 'tooltool.py': '/tools/tooltool.py', 08:07:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:07:31 INFO - '/tools/misc-python/virtualenv.py')}, 08:07:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:07:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:07:31 INFO - 'installer_path': 'installer.exe', 08:07:31 INFO - 'log_level': 'info', 08:07:31 INFO - 'log_name': 'talos', 08:07:31 INFO - 'log_to_console': True, 08:07:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:07:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:07:31 INFO - 'opt_config_files': (), 08:07:31 INFO - 'pip_index': False, 08:07:31 INFO - 'sps_profile': False, 08:07:31 INFO - 'sps_profile_interval': 0, 08:07:31 INFO - 'suite': 'dromaeojs', 08:07:31 INFO - 'system_bits': '32', 08:07:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:07:31 INFO - 'title': 'talos-linux64-ix-033', 08:07:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:07:31 INFO - 'use_talos_json': True, 08:07:31 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 08:07:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:07:31 INFO - 'work_dir': 'build'} 08:07:31 INFO - ##### 08:07:31 INFO - ##### Running clobber step. 08:07:31 INFO - ##### 08:07:31 INFO - Running pre-action listener: _resource_record_pre_action 08:07:31 INFO - Running main action method: clobber 08:07:31 INFO - rmtree: /builds/slave/test-pgo/build 08:07:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 08:07:33 INFO - Running post-action listener: _resource_record_post_action 08:07:33 INFO - ##### 08:07:33 INFO - ##### Running read-buildbot-config step. 08:07:33 INFO - ##### 08:07:33 INFO - Running pre-action listener: _resource_record_pre_action 08:07:33 INFO - Running main action method: read_buildbot_config 08:07:33 INFO - Using buildbot properties: 08:07:33 INFO - { 08:07:33 INFO - "project": "", 08:07:33 INFO - "product": "firefox", 08:07:33 INFO - "script_repo_revision": "production", 08:07:33 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:07:33 INFO - "repository": "", 08:07:33 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:07:33 INFO - "buildid": "20160315053010", 08:07:33 INFO - "pgo_build": "True", 08:07:33 INFO - "basedir": "/builds/slave/test-pgo", 08:07:33 INFO - "buildnumber": 1001, 08:07:33 INFO - "slavename": "talos-linux64-ix-033", 08:07:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:07:33 INFO - "platform": "ubuntu64_hw", 08:07:33 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:07:33 INFO - "branch": "fx-team", 08:07:33 INFO - "repo_path": "integration/fx-team", 08:07:33 INFO - "revision": "c55260f518359813e95ac59b4af8b54f09946f49", 08:07:33 INFO - "stage_platform": "linux64-pgo", 08:07:33 INFO - "builduid": "65a9775154fd41d78e133202fe258ba7", 08:07:33 INFO - "slavebuilddir": "test" 08:07:33 INFO - } 08:07:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/Dct_jsB9QN6P-jwKyj07fg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 08:07:33 INFO - Running post-action listener: _resource_record_post_action 08:07:33 INFO - ##### 08:07:33 INFO - ##### Running download-and-extract step. 08:07:33 INFO - ##### 08:07:33 INFO - Running pre-action listener: _resource_record_pre_action 08:07:33 INFO - Running main action method: download_and_extract 08:07:33 INFO - mkdir: /builds/slave/test-pgo/build/tests 08:07:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:33 INFO - https://queue.taskcluster.net/v1/task/Dct_jsB9QN6P-jwKyj07fg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:07:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dct_jsB9QN6P-jwKyj07fg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:07:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dct_jsB9QN6P-jwKyj07fg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:07:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dct_jsB9QN6P-jwKyj07fg/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 08:07:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dct_jsB9QN6P-jwKyj07fg/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 08:07:37 INFO - Downloaded 1361 bytes. 08:07:37 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:07:37 INFO - Using the following test package requirements: 08:07:37 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:07:37 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:37 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:07:37 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:37 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:07:37 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:37 INFO - u'jsshell-linux-x86_64.zip'], 08:07:37 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:37 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:07:37 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:07:37 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:37 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:07:37 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:37 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:07:37 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:37 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:07:37 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:37 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:07:37 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:07: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')]} 08:07:37 INFO - https://queue.taskcluster.net/v1/task/Dct_jsB9QN6P-jwKyj07fg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:07:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dct_jsB9QN6P-jwKyj07fg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:07:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dct_jsB9QN6P-jwKyj07fg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:07:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dct_jsB9QN6P-jwKyj07fg/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 08:07:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dct_jsB9QN6P-jwKyj07fg/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 08:07:43 INFO - Downloaded 23561864 bytes. 08:07:43 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'] 08:07:43 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 08:07:44 INFO - Return code: 0 08:07:44 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 08:07:44 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')]} 08:07:44 INFO - https://queue.taskcluster.net/v1/task/Dct_jsB9QN6P-jwKyj07fg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:07:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dct_jsB9QN6P-jwKyj07fg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:07:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dct_jsB9QN6P-jwKyj07fg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:07:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dct_jsB9QN6P-jwKyj07fg/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 08:07:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dct_jsB9QN6P-jwKyj07fg/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 08:07:50 INFO - Downloaded 23561864 bytes. 08:07:50 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'] 08:07:50 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 08:07:51 INFO - Return code: 0 08:07:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:51 INFO - https://queue.taskcluster.net/v1/task/Dct_jsB9QN6P-jwKyj07fg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:07:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dct_jsB9QN6P-jwKyj07fg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:07:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dct_jsB9QN6P-jwKyj07fg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:07:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dct_jsB9QN6P-jwKyj07fg/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 08:07:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dct_jsB9QN6P-jwKyj07fg/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 08:07:52 INFO - Downloaded 10845263 bytes. 08:07:52 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'] 08:07:52 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 08:07:52 INFO - Return code: 0 08:07: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')]} 08:07:52 INFO - https://queue.taskcluster.net/v1/task/Dct_jsB9QN6P-jwKyj07fg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:07:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dct_jsB9QN6P-jwKyj07fg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:07:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dct_jsB9QN6P-jwKyj07fg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:07:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dct_jsB9QN6P-jwKyj07fg/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 08:07:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dct_jsB9QN6P-jwKyj07fg/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 08:07:54 INFO - Downloaded 57649780 bytes. 08:07:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Dct_jsB9QN6P-jwKyj07fg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:07:54 INFO - mkdir: /builds/slave/test-pgo/properties 08:07:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 08:07:54 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 08:07:54 INFO - Contents: 08:07:54 INFO - build_url:https://queue.taskcluster.net/v1/task/Dct_jsB9QN6P-jwKyj07fg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:07:54 INFO - Running post-action listener: _resource_record_post_action 08:07:54 INFO - Running post-action listener: set_extra_try_arguments 08:07:54 INFO - ##### 08:07:54 INFO - ##### Running populate-webroot step. 08:07:54 INFO - ##### 08:07:54 INFO - Running pre-action listener: _resource_record_pre_action 08:07:54 INFO - Running main action method: populate_webroot 08:07:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:07:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:07:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:07:54 INFO - '--tppagecycles', 08:07:54 INFO - '7'], 08:07:54 INFO - 'tests': ['tsvgm']}}, 08:07:54 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:07:54 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:07:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:07:54 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 08:07:54 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:07:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:07:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:07:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:54 INFO - 'talos_options': ['--e10s'], 08:07:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:07:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:54 INFO - 'tests': ['damp', 'tps']}, 08:07:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:54 INFO - 'talos_options': ['--e10s'], 08:07:54 INFO - 'tests': ['damp', 'tps']}, 08:07:54 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:07:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:07:54 INFO - 'other': {'tests': ['a11yr', 08:07:54 INFO - 'ts_paint', 08:07:54 INFO - 'tpaint', 08:07:54 INFO - 'sessionrestore', 08:07:54 INFO - 'sessionrestore_no_auto_restore', 08:07:54 INFO - 'tabpaint']}, 08:07:54 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:07:54 INFO - 'tests': ['a11yr', 08:07:54 INFO - 'ts_paint', 08:07:54 INFO - 'tpaint', 08:07:54 INFO - 'sessionrestore', 08:07:54 INFO - 'sessionrestore_no_auto_restore', 08:07:54 INFO - 'tabpaint']}, 08:07:54 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:07:54 INFO - 'tests': ['a11yr', 08:07:54 INFO - 'ts_paint', 08:07:54 INFO - 'tpaint', 08:07:54 INFO - 'sessionrestore', 08:07:54 INFO - 'sessionrestore_no_auto_restore', 08:07:54 INFO - 'tabpaint']}, 08:07:54 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:07:54 INFO - 'tests': ['a11yr', 08:07:54 INFO - 'ts_paint', 08:07:54 INFO - 'tpaint', 08:07:54 INFO - 'sessionrestore', 08:07:54 INFO - 'sessionrestore_no_auto_restore', 08:07:54 INFO - 'tabpaint']}, 08:07:54 INFO - 'other_l64': {'tests': ['a11yr', 08:07:54 INFO - 'ts_paint', 08:07:54 INFO - 'tpaint', 08:07:54 INFO - 'sessionrestore', 08:07:54 INFO - 'sessionrestore_no_auto_restore', 08:07:54 INFO - 'tabpaint']}, 08:07:54 INFO - 'other_nol64': {'tests': ['a11yr', 08:07:54 INFO - 'ts_paint', 08:07:54 INFO - 'tpaint', 08:07:54 INFO - 'sessionrestore', 08:07:54 INFO - 'sessionrestore_no_auto_restore', 08:07:54 INFO - 'tabpaint']}, 08:07:54 INFO - 'svgr': {'tests': ['tsvgx', 08:07:54 INFO - 'tsvgr_opacity', 08:07:54 INFO - 'tart', 08:07:54 INFO - 'tscrollx', 08:07:54 INFO - 'cart']}, 08:07:54 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:07:54 INFO - 'tests': ['tsvgx', 08:07:54 INFO - 'tsvgr_opacity', 08:07:54 INFO - 'tart', 08:07:54 INFO - 'tscrollx', 08:07:54 INFO - 'cart']}, 08:07:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:54 INFO - 'tests': ['tp5o']}, 08:07:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:54 INFO - 'talos_options': ['--e10s'], 08:07:54 INFO - 'tests': ['tp5o']}, 08:07:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:54 INFO - 'talos_options': ['--xperf_path', 08:07:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:07:54 INFO - 'tests': ['tp5n']}, 08:07:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:54 INFO - 'talos_options': ['--e10s', 08:07:54 INFO - '--xperf_path', 08:07:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:07:54 INFO - 'tests': ['tp5n']}}, 08:07:54 INFO - 'talos.zip': {'path': '', 08:07:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:07:54 INFO - Running post-action listener: _resource_record_post_action 08:07:54 INFO - ##### 08:07:54 INFO - ##### Running create-virtualenv step. 08:07:54 INFO - ##### 08:07:54 INFO - Running pre-action listener: _resource_record_pre_action 08:07:54 INFO - Running main action method: create_virtualenv 08:07:54 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 08:07:54 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 08:07:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 08:07:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:07:55 INFO - Using real prefix '/usr' 08:07:55 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 08:07:56 INFO - Installing distribute.............................................................................................................................................................................................done. 08:07:58 INFO - Installing pip.................done. 08:07:58 INFO - Return code: 0 08:07:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 08:07:58 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')]} 08:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:58 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')]} 08:07:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:58 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 0x7f1979bb5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23bf6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244e920>, '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 0x244f820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244fcb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1458054131.57783-1983725906', '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 08:07:58 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 08:07:58 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 08:07:58 INFO - Using env: {'DISPLAY': ':0', 08:07:58 INFO - 'HOME': '/home/cltbld', 08:07:58 INFO - 'LANG': 'en_US.UTF-8', 08:07:58 INFO - 'LANGUAGE': 'en_US:en', 08:07:58 INFO - 'LOGNAME': 'cltbld', 08:07:58 INFO - 'MAIL': '/var/mail/cltbld', 08:07:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:58 INFO - 'MOZ_NO_REMOTE': '1', 08:07:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:07:58 INFO - 'NO_EM_RESTART': '1', 08:07:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:07:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:07:58 INFO - 'PWD': '/builds/slave/test-pgo', 08:07:58 INFO - 'SHELL': '/bin/bash', 08:07:58 INFO - 'SHLVL': '1', 08:07:58 INFO - 'TERM': 'linux', 08:07:58 INFO - 'TMOUT': '86400', 08:07:58 INFO - 'USER': 'cltbld', 08:07:58 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1458054131.57783-1983725906', 08:07:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:58 INFO - '_': '/tools/buildbot/bin/python'} 08:07:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:58 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 08:07:58 INFO - Cleaning up... 08:07:58 INFO - Return code: 0 08:07:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 08:07:58 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')]} 08:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:58 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')]} 08:07:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:58 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 0x7f1979bb5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23bf6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244e920>, '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 0x244f820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244fcb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1458054131.57783-1983725906', '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 08:07:58 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 08:07:58 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 08:07:58 INFO - Using env: {'DISPLAY': ':0', 08:07:58 INFO - 'HOME': '/home/cltbld', 08:07:58 INFO - 'LANG': 'en_US.UTF-8', 08:07:58 INFO - 'LANGUAGE': 'en_US:en', 08:07:58 INFO - 'LOGNAME': 'cltbld', 08:07:58 INFO - 'MAIL': '/var/mail/cltbld', 08:07:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:58 INFO - 'MOZ_NO_REMOTE': '1', 08:07:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:07:58 INFO - 'NO_EM_RESTART': '1', 08:07:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:07:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:07:58 INFO - 'PWD': '/builds/slave/test-pgo', 08:07:58 INFO - 'SHELL': '/bin/bash', 08:07:58 INFO - 'SHLVL': '1', 08:07:58 INFO - 'TERM': 'linux', 08:07:58 INFO - 'TMOUT': '86400', 08:07:58 INFO - 'USER': 'cltbld', 08:07:58 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1458054131.57783-1983725906', 08:07:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:58 INFO - '_': '/tools/buildbot/bin/python'} 08:07:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:58 INFO - Downloading/unpacking psutil>=0.7.1 08:07:58 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 08:07:58 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 08:07:58 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 08:07:58 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 08:07:58 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 08:07:58 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 08:08:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 08:08:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:08:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:08:00 INFO - Installing collected packages: psutil 08:08:00 INFO - Running setup.py install for psutil 08:08:00 INFO - building 'psutil._psutil_linux' extension 08:08:00 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 08:08:01 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 08:08:01 INFO - building 'psutil._psutil_posix' extension 08:08:01 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 08:08:01 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 08:08:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:08:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:08:01 INFO - Successfully installed psutil 08:08:01 INFO - Cleaning up... 08:08:01 INFO - Return code: 0 08:08:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 08:08:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1979bb5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23bf6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244e920>, '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 0x244f820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244fcb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1458054131.57783-1983725906', '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 08:08:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 08:08:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:08:01 INFO - Using env: {'DISPLAY': ':0', 08:08:01 INFO - 'HOME': '/home/cltbld', 08:08:01 INFO - 'LANG': 'en_US.UTF-8', 08:08:01 INFO - 'LANGUAGE': 'en_US:en', 08:08:01 INFO - 'LOGNAME': 'cltbld', 08:08:01 INFO - 'MAIL': '/var/mail/cltbld', 08:08:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:01 INFO - 'MOZ_NO_REMOTE': '1', 08:08:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:01 INFO - 'NO_EM_RESTART': '1', 08:08:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:08:01 INFO - 'PWD': '/builds/slave/test-pgo', 08:08:01 INFO - 'SHELL': '/bin/bash', 08:08:01 INFO - 'SHLVL': '1', 08:08:01 INFO - 'TERM': 'linux', 08:08:01 INFO - 'TMOUT': '86400', 08:08:01 INFO - 'USER': 'cltbld', 08:08:01 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1458054131.57783-1983725906', 08:08:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:01 INFO - '_': '/tools/buildbot/bin/python'} 08:08:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:08:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:08:03 INFO - Installing collected packages: mozsystemmonitor 08:08:03 INFO - Running setup.py install for mozsystemmonitor 08:08:03 INFO - Successfully installed mozsystemmonitor 08:08:03 INFO - Cleaning up... 08:08:03 INFO - Return code: 0 08:08:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 08:08:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1979bb5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23bf6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244e920>, '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 0x244f820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244fcb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1458054131.57783-1983725906', '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 08:08:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 08:08:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:08:03 INFO - Using env: {'DISPLAY': ':0', 08:08:03 INFO - 'HOME': '/home/cltbld', 08:08:03 INFO - 'LANG': 'en_US.UTF-8', 08:08:03 INFO - 'LANGUAGE': 'en_US:en', 08:08:03 INFO - 'LOGNAME': 'cltbld', 08:08:03 INFO - 'MAIL': '/var/mail/cltbld', 08:08:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:03 INFO - 'MOZ_NO_REMOTE': '1', 08:08:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:03 INFO - 'NO_EM_RESTART': '1', 08:08:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:08:03 INFO - 'PWD': '/builds/slave/test-pgo', 08:08:03 INFO - 'SHELL': '/bin/bash', 08:08:03 INFO - 'SHLVL': '1', 08:08:03 INFO - 'TERM': 'linux', 08:08:03 INFO - 'TMOUT': '86400', 08:08:03 INFO - 'USER': 'cltbld', 08:08:03 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1458054131.57783-1983725906', 08:08:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:03 INFO - '_': '/tools/buildbot/bin/python'} 08:08:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:03 INFO - Downloading/unpacking blobuploader==1.2.4 08:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:05 INFO - Downloading blobuploader-1.2.4.tar.gz 08:08:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:08:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:08:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 08:08:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:06 INFO - Downloading docopt-0.6.1.tar.gz 08:08:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 08:08:06 INFO - Installing collected packages: blobuploader, requests, docopt 08:08:06 INFO - Running setup.py install for blobuploader 08:08:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:08:06 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 08:08:06 INFO - Running setup.py install for requests 08:08:06 INFO - Running setup.py install for docopt 08:08:07 INFO - Successfully installed blobuploader requests docopt 08:08:07 INFO - Cleaning up... 08:08:07 INFO - Return code: 0 08:08:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:07 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 0x7f1979bb5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23bf6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244e920>, '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 0x244f820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244fcb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1458054131.57783-1983725906', '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 08:08:07 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 08:08:07 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 08:08:07 INFO - Using env: {'DISPLAY': ':0', 08:08:07 INFO - 'HOME': '/home/cltbld', 08:08:07 INFO - 'LANG': 'en_US.UTF-8', 08:08:07 INFO - 'LANGUAGE': 'en_US:en', 08:08:07 INFO - 'LOGNAME': 'cltbld', 08:08:07 INFO - 'MAIL': '/var/mail/cltbld', 08:08:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:07 INFO - 'MOZ_NO_REMOTE': '1', 08:08:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:07 INFO - 'NO_EM_RESTART': '1', 08:08:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:08:07 INFO - 'PWD': '/builds/slave/test-pgo', 08:08:07 INFO - 'SHELL': '/bin/bash', 08:08:07 INFO - 'SHLVL': '1', 08:08:07 INFO - 'TERM': 'linux', 08:08:07 INFO - 'TMOUT': '86400', 08:08:07 INFO - 'USER': 'cltbld', 08:08:07 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1458054131.57783-1983725906', 08:08:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:07 INFO - '_': '/tools/buildbot/bin/python'} 08:08:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:08:07 INFO - Running setup.py (path:/tmp/pip-3qZqgE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:08:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:08:07 INFO - Running setup.py (path:/tmp/pip-WEHdJb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:08:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:08:07 INFO - Running setup.py (path:/tmp/pip-XQLOgi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:08:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:08:07 INFO - Running setup.py (path:/tmp/pip-2KAkyl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:08:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:08:07 INFO - Running setup.py (path:/tmp/pip-Fsg_U1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:08:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:08:07 INFO - Running setup.py (path:/tmp/pip-17tDtd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:08:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:08:07 INFO - Running setup.py (path:/tmp/pip-WZRtZI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:08:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:08:07 INFO - Running setup.py (path:/tmp/pip-0mqlTK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:08:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:08:07 INFO - Running setup.py (path:/tmp/pip-VoQTL1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:08:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:08:07 INFO - Running setup.py (path:/tmp/pip-8Ej4Jv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:08:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:08:08 INFO - Running setup.py (path:/tmp/pip-cJMgcG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:08:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:08:08 INFO - Running setup.py (path:/tmp/pip-bnFULb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:08:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:08:08 INFO - Running setup.py (path:/tmp/pip-wNLGBo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:08:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:08:08 INFO - Running setup.py (path:/tmp/pip-6lDuRJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:08:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:08:08 INFO - Running setup.py (path:/tmp/pip-BsXb5f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:08:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:08:08 INFO - Running setup.py (path:/tmp/pip-syQp37-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:08:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:08:08 INFO - Running setup.py (path:/tmp/pip-cjToWb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:08:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:08:08 INFO - Running setup.py install for manifestparser 08:08:08 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 08:08:08 INFO - Running setup.py install for mozcrash 08:08:08 INFO - Running setup.py install for mozdebug 08:08:08 INFO - Running setup.py install for mozdevice 08:08:08 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 08:08:08 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 08:08:08 INFO - Running setup.py install for mozfile 08:08:09 INFO - Running setup.py install for mozhttpd 08:08:09 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 08:08:09 INFO - Running setup.py install for mozinfo 08:08:09 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 08:08:09 INFO - Running setup.py install for mozInstall 08:08:09 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 08:08:09 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 08:08:09 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 08:08:09 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 08:08:09 INFO - Running setup.py install for mozleak 08:08:09 INFO - Running setup.py install for mozlog 08:08:09 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 08:08:09 INFO - Running setup.py install for moznetwork 08:08:09 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 08:08:09 INFO - Running setup.py install for mozprocess 08:08:09 INFO - Running setup.py install for mozprofile 08:08:09 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 08:08:09 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 08:08:09 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 08:08:09 INFO - Running setup.py install for mozrunner 08:08:09 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 08:08:09 INFO - Running setup.py install for mozscreenshot 08:08:10 INFO - Running setup.py install for moztest 08:08:10 INFO - Running setup.py install for mozversion 08:08:10 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 08:08:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:08:10 INFO - Cleaning up... 08:08:10 INFO - Return code: 0 08:08:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:08: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')]} 08:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08: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')]} 08:08:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:10 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 0x7f1979bb5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23bf6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244e920>, '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 0x244f820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244fcb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1458054131.57783-1983725906', '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 08:08:10 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 08:08:10 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 08:08:10 INFO - Using env: {'DISPLAY': ':0', 08:08:10 INFO - 'HOME': '/home/cltbld', 08:08:10 INFO - 'LANG': 'en_US.UTF-8', 08:08:10 INFO - 'LANGUAGE': 'en_US:en', 08:08:10 INFO - 'LOGNAME': 'cltbld', 08:08:10 INFO - 'MAIL': '/var/mail/cltbld', 08:08:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:10 INFO - 'MOZ_NO_REMOTE': '1', 08:08:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:10 INFO - 'NO_EM_RESTART': '1', 08:08:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:08:10 INFO - 'PWD': '/builds/slave/test-pgo', 08:08:10 INFO - 'SHELL': '/bin/bash', 08:08:10 INFO - 'SHLVL': '1', 08:08:10 INFO - 'TERM': 'linux', 08:08:10 INFO - 'TMOUT': '86400', 08:08:10 INFO - 'USER': 'cltbld', 08:08:10 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1458054131.57783-1983725906', 08:08:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:10 INFO - '_': '/tools/buildbot/bin/python'} 08:08:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:08:10 INFO - Running setup.py (path:/tmp/pip-J2UyX9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:08:10 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)) 08:08:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:08:10 INFO - Running setup.py (path:/tmp/pip-tQYTL4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:08:10 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)) 08:08:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:08:10 INFO - Running setup.py (path:/tmp/pip-JhQvbB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:08:10 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)) 08:08:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:08:10 INFO - Running setup.py (path:/tmp/pip-5xPeHP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:08:10 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)) 08:08:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:08:10 INFO - Running setup.py (path:/tmp/pip-jJYVkX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:08:10 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)) 08:08:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:08:10 INFO - Running setup.py (path:/tmp/pip-1GMUHt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:08:10 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)) 08:08:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:08:10 INFO - Running setup.py (path:/tmp/pip-xB_L0h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:08:11 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)) 08:08:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:08:11 INFO - Running setup.py (path:/tmp/pip-96YTP8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:08:11 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)) 08:08:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:08:11 INFO - Running setup.py (path:/tmp/pip-jlCTXw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:08:11 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)) 08:08:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:08:11 INFO - Running setup.py (path:/tmp/pip-Xn4sBP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:08:11 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)) 08:08:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:08:11 INFO - Running setup.py (path:/tmp/pip-xQPAYv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:08:11 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)) 08:08:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:08:11 INFO - Running setup.py (path:/tmp/pip-wGHD7W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:08:11 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)) 08:08:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:08:11 INFO - Running setup.py (path:/tmp/pip-mjn8g8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:08:11 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)) 08:08:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:08:11 INFO - Running setup.py (path:/tmp/pip-KNXnYL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:08:11 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)) 08:08:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:08:11 INFO - Running setup.py (path:/tmp/pip-Qj4wpo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:08:11 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)) 08:08:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:08:11 INFO - Running setup.py (path:/tmp/pip-DJwTuZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:08:11 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)) 08:08:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:08:11 INFO - Running setup.py (path:/tmp/pip-sk1sMr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:08:11 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)) 08:08:11 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)) 08:08:11 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)) 08:08:11 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)) 08:08:11 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)) 08:08:11 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)) 08:08:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 08:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:13 INFO - Downloading blessings-1.6.tar.gz 08:08:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 08:08:13 INFO - Installing collected packages: blessings 08:08:13 INFO - Running setup.py install for blessings 08:08:13 INFO - Successfully installed blessings 08:08:13 INFO - Cleaning up... 08:08:13 INFO - Return code: 0 08:08:13 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 08:08:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:08:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:08:14 INFO - Reading from file tmpfile_stdout 08:08:14 INFO - Current package versions: 08:08:14 INFO - argparse == 1.2.1 08:08:14 INFO - blessings == 1.6 08:08:14 INFO - blobuploader == 1.2.4 08:08:14 INFO - docopt == 0.6.1 08:08:14 INFO - manifestparser == 1.1 08:08:14 INFO - mozInstall == 1.12 08:08:14 INFO - mozcrash == 0.17 08:08:14 INFO - mozdebug == 0.1 08:08:14 INFO - mozdevice == 0.48 08:08:14 INFO - mozfile == 1.2 08:08:14 INFO - mozhttpd == 0.7 08:08:14 INFO - mozinfo == 0.9 08:08:14 INFO - mozleak == 0.1 08:08:14 INFO - mozlog == 3.1 08:08:14 INFO - moznetwork == 0.27 08:08:14 INFO - mozprocess == 0.22 08:08:14 INFO - mozprofile == 0.28 08:08:14 INFO - mozrunner == 6.11 08:08:14 INFO - mozscreenshot == 0.1 08:08:14 INFO - mozsystemmonitor == 0.0 08:08:14 INFO - moztest == 0.7 08:08:14 INFO - mozversion == 1.4 08:08:14 INFO - psutil == 3.1.1 08:08:14 INFO - requests == 1.2.3 08:08:14 INFO - wsgiref == 0.1.2 08:08:14 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:08:14 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')]} 08:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:14 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')]} 08:08:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:14 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 0x7f1979bb5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23bf6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244e920>, '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 0x244f820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244fcb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1458054131.57783-1983725906', '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 08:08:14 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 08:08:14 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 08:08:14 INFO - Using env: {'DISPLAY': ':0', 08:08:14 INFO - 'HOME': '/home/cltbld', 08:08:14 INFO - 'LANG': 'en_US.UTF-8', 08:08:14 INFO - 'LANGUAGE': 'en_US:en', 08:08:14 INFO - 'LOGNAME': 'cltbld', 08:08:14 INFO - 'MAIL': '/var/mail/cltbld', 08:08:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:14 INFO - 'MOZ_NO_REMOTE': '1', 08:08:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:14 INFO - 'NO_EM_RESTART': '1', 08:08:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:08:14 INFO - 'PWD': '/builds/slave/test-pgo', 08:08:14 INFO - 'SHELL': '/bin/bash', 08:08:14 INFO - 'SHLVL': '1', 08:08:14 INFO - 'TERM': 'linux', 08:08:14 INFO - 'TMOUT': '86400', 08:08:14 INFO - 'USER': 'cltbld', 08:08:14 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1458054131.57783-1983725906', 08:08:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:14 INFO - '_': '/tools/buildbot/bin/python'} 08:08:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:14 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)) 08:08:14 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)) 08:08:14 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)) 08:08:14 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)) 08:08:14 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)) 08:08:14 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)) 08:08:14 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)) 08:08:14 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)) 08:08:14 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)) 08:08:14 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)) 08:08:14 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)) 08:08:14 INFO - Cleaning up... 08:08:14 INFO - Return code: 0 08:08:14 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 08:08:14 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')]} 08:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:14 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')]} 08:08:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:14 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 0x7f1979bb5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23bf6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244e920>, '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 0x244f820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244fcb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1458054131.57783-1983725906', '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 08:08:14 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 08:08:14 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 08:08:14 INFO - Using env: {'DISPLAY': ':0', 08:08:14 INFO - 'HOME': '/home/cltbld', 08:08:14 INFO - 'LANG': 'en_US.UTF-8', 08:08:14 INFO - 'LANGUAGE': 'en_US:en', 08:08:14 INFO - 'LOGNAME': 'cltbld', 08:08:14 INFO - 'MAIL': '/var/mail/cltbld', 08:08:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:14 INFO - 'MOZ_NO_REMOTE': '1', 08:08:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:14 INFO - 'NO_EM_RESTART': '1', 08:08:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:08:14 INFO - 'PWD': '/builds/slave/test-pgo', 08:08:14 INFO - 'SHELL': '/bin/bash', 08:08:14 INFO - 'SHLVL': '1', 08:08:14 INFO - 'TERM': 'linux', 08:08:14 INFO - 'TMOUT': '86400', 08:08:14 INFO - 'USER': 'cltbld', 08:08:14 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1458054131.57783-1983725906', 08:08:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:14 INFO - '_': '/tools/buildbot/bin/python'} 08:08:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:14 INFO - Downloading/unpacking jsonschema 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:08:16 INFO - Downloading/unpacking functools32 (from jsonschema) 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08:16 INFO - Downloading functools32-3.2.3-2.tar.gz 08:08:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 08:08:16 INFO - warning: no files found matching '*.txt' 08:08:16 INFO - no previously-included directories found matching 'build' 08:08:16 INFO - no previously-included directories found matching 'dist' 08:08:16 INFO - no previously-included directories found matching '.git*' 08:08:16 INFO - Installing collected packages: jsonschema, functools32 08:08:16 INFO - Running setup.py install for functools32 08:08:16 INFO - warning: no files found matching '*.txt' 08:08:16 INFO - no previously-included directories found matching 'build' 08:08:16 INFO - no previously-included directories found matching 'dist' 08:08:16 INFO - no previously-included directories found matching '.git*' 08:08:16 INFO - Successfully installed jsonschema functools32 08:08:16 INFO - Cleaning up... 08:08:16 INFO - Return code: 0 08:08:16 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 08:08: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')]} 08:08:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08: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')]} 08:08:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1979bb5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23bf6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244e920>, '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 0x244f820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244fcb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1458054131.57783-1983725906', '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 08:08: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', 'flake8'] in /builds/slave/test-pgo/build 08:08: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 flake8 08:08:16 INFO - Using env: {'DISPLAY': ':0', 08:08:16 INFO - 'HOME': '/home/cltbld', 08:08:16 INFO - 'LANG': 'en_US.UTF-8', 08:08:16 INFO - 'LANGUAGE': 'en_US:en', 08:08:16 INFO - 'LOGNAME': 'cltbld', 08:08:16 INFO - 'MAIL': '/var/mail/cltbld', 08:08:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:16 INFO - 'MOZ_NO_REMOTE': '1', 08:08:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:16 INFO - 'NO_EM_RESTART': '1', 08:08:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:08:16 INFO - 'PWD': '/builds/slave/test-pgo', 08:08:16 INFO - 'SHELL': '/bin/bash', 08:08:16 INFO - 'SHLVL': '1', 08:08:16 INFO - 'TERM': 'linux', 08:08:16 INFO - 'TMOUT': '86400', 08:08:16 INFO - 'USER': 'cltbld', 08:08:16 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1458054131.57783-1983725906', 08:08:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:16 INFO - '_': '/tools/buildbot/bin/python'} 08:08:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:17 INFO - Downloading/unpacking flake8 08:08:17 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 08:08:17 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 08:08:17 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 08:08:17 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 08:08:17 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 08:08:17 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 08:08:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:08:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:08:18 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 08:08:18 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 08:08:18 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 08:08:18 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 08:08:18 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 08:08:18 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 08:08:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:08:19 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 08:08:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:08:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:08:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:08:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:08:19 INFO - no previously-included directories found matching 'docs/_build' 08:08:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:08:19 INFO - Running setup.py install for pep8 08:08:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:08:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:08:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:08:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:08:19 INFO - no previously-included directories found matching 'docs/_build' 08:08:19 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 08:08:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:08:19 INFO - Cleaning up... 08:08:19 INFO - Return code: 0 08:08:19 INFO - Running post-action listener: _resource_record_post_action 08:08:19 INFO - Running post-action listener: _start_resource_monitoring 08:08:19 INFO - Starting resource monitoring. 08:08:19 INFO - ##### 08:08:19 INFO - ##### Running install step. 08:08:19 INFO - ##### 08:08:19 INFO - Running pre-action listener: _resource_record_pre_action 08:08:19 INFO - Running main action method: install 08:08:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:08:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:08:20 INFO - Reading from file tmpfile_stdout 08:08:20 INFO - Detecting whether we're running mozinstall >=1.0... 08:08:20 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 08:08:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 08:08:20 INFO - Reading from file tmpfile_stdout 08:08:20 INFO - Output received: 08:08:20 INFO - Usage: mozinstall [options] installer 08:08:20 INFO - Options: 08:08:20 INFO - -h, --help show this help message and exit 08:08:20 INFO - -d DEST, --destination=DEST 08:08:20 INFO - Directory to install application into. [default: 08:08:20 INFO - "/builds/slave/test-pgo"] 08:08:20 INFO - --app=APP Application being installed. [default: firefox] 08:08:20 INFO - mkdir: /builds/slave/test-pgo/build/application 08:08:20 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'] 08:08:20 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 08:08:42 INFO - Reading from file tmpfile_stdout 08:08:42 INFO - Output received: 08:08:42 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 08:08:42 INFO - Running post-action listener: _resource_record_post_action 08:08:42 INFO - ##### 08:08:42 INFO - ##### Running run-tests step. 08:08:42 INFO - ##### 08:08:42 INFO - Running pre-action listener: _resource_record_pre_action 08:08:42 INFO - Running main action method: run_tests 08:08:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 08:08:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 08:08:42 INFO - Python 2.7.3 08:08:42 INFO - Return code: 0 08:08:42 INFO - grabbing minidump binary from tooltool 08:08:42 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')]} 08:08:42 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 0x244e920>, '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 0x244f820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244fcb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 08:08:42 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 08:08:42 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 08:08:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:08:42 INFO - Return code: 0 08:08:42 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 08:08:42 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 08:08:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 08:08:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 08:08:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 08:08:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 08:08:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 08:08:43 INFO - Return code: 0 08:08:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Dct_jsB9QN6P-jwKyj07fg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 08:08:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Dct_jsB9QN6P-jwKyj07fg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 08:08:43 INFO - Using env: {'DISPLAY': ':0', 08:08:43 INFO - 'HOME': '/home/cltbld', 08:08:43 INFO - 'LANG': 'en_US.UTF-8', 08:08:43 INFO - 'LANGUAGE': 'en_US:en', 08:08:43 INFO - 'LOGNAME': 'cltbld', 08:08:43 INFO - 'MAIL': '/var/mail/cltbld', 08:08:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:08:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 08:08:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:43 INFO - 'MOZ_NO_REMOTE': '1', 08:08:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:08:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:43 INFO - 'NO_EM_RESTART': '1', 08:08:43 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:08:43 INFO - 'PWD': '/builds/slave/test-pgo', 08:08:43 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 08:08:43 INFO - 'SHELL': '/bin/bash', 08:08:43 INFO - 'SHLVL': '1', 08:08:43 INFO - 'TERM': 'linux', 08:08:43 INFO - 'TMOUT': '86400', 08:08:43 INFO - 'USER': 'cltbld', 08:08:43 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1458054131.57783-1983725906', 08:08:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:43 INFO - '_': '/tools/buildbot/bin/python'} 08:08:43 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Dct_jsB9QN6P-jwKyj07fg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:08:44 INFO - mozversion application_buildid: 20160315053010 08:08:44 INFO - mozversion application_changeset: c55260f518359813e95ac59b4af8b54f09946f49 08:08:44 INFO - mozversion application_display_name: Nightly 08:08:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:08:44 INFO - mozversion application_name: Firefox 08:08:44 INFO - mozversion application_remotingname: firefox 08:08:44 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:08:44 INFO - mozversion application_vendor: Mozilla 08:08:44 INFO - mozversion application_version: 48.0a1 08:08:44 INFO - mozversion platform_buildid: 20160315053010 08:08:44 INFO - mozversion platform_changeset: c55260f518359813e95ac59b4af8b54f09946f49 08:08:44 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:08:44 INFO - mozversion platform_version: 48.0a1 08:08:44 INFO - using testdate: 1458054524 08:08:44 INFO - actual date: 1458054524 08:08:44 INFO - starting webserver on 'localhost:55903' 08:08:44 INFO - SUITE-START | Running 2 tests 08:08:44 INFO - TEST-START | dromaeo_css 08:08:44 INFO - operating with platform_type : linux_ 08:08:44 INFO - Initialising browser for dromaeo_css test... 08:08:44 INFO - TEST-INFO | started process 23832 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmppTfnnu/profile http://localhost:55903/getInfo.html) 08:10:04 INFO - PROCESS | 23832 | __metrics Screen width/height:1600/1200 08:10:04 INFO - PROCESS | 23832 | colorDepth:24 08:10:04 INFO - PROCESS | 23832 | Browser inner width/height: 1024/697 08:10:04 INFO - PROCESS | 23832 | __metrics 08:10:09 ERROR - PROCESS | 23832 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:10:09 INFO - PROCESS | 23832 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 08:10:11 INFO - TEST-INFO | 23832: exit 0 08:10:11 INFO - Browser initialized. 08:10:11 INFO - Running cycle 1/1 for dromaeo_css test... 08:10:11 INFO - TEST-INFO | started process 23930 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmppTfnnu/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:10:23 INFO - PROCESS | 23930 | RSS: Main: 151031808 08:10:23 INFO - PROCESS | 23930 | 08:11:13 INFO - PROCESS | 23930 | 1458054673789 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] 08:13:22 INFO - PROCESS | 23930 | Cycle 1(1): loaded http://localhost:55903/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55903/tests/dromaeo/cssquery-ext.html) 08:13:23 INFO - PROCESS | 23930 | RSS: Main: 268513280 08:13:23 INFO - PROCESS | 23930 | 08:16:26 INFO - PROCESS | 23930 | Cycle 1(1): loaded http://localhost:55903/tests/dromaeo/cssquery-ext.html (next: http://localhost:55903/tests/dromaeo/cssquery-jquery.html) 08:16:26 INFO - PROCESS | 23930 | RSS: Main: 237412352 08:16:26 INFO - PROCESS | 23930 | 08:19:28 INFO - PROCESS | 23930 | Cycle 1(1): loaded http://localhost:55903/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55903/tests/dromaeo/cssquery-mootools.html) 08:19:29 INFO - PROCESS | 23930 | RSS: Main: 243347456 08:19:29 INFO - PROCESS | 23930 | 08:22:30 INFO - PROCESS | 23930 | Cycle 1(1): loaded http://localhost:55903/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55903/tests/dromaeo/cssquery-prototype.html) 08:22:31 INFO - PROCESS | 23930 | RSS: Main: 220151808 08:22:31 INFO - PROCESS | 23930 | 08:25:34 INFO - PROCESS | 23930 | Cycle 1(1): loaded http://localhost:55903/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55903/tests/dromaeo/cssquery-yui.html) 08:25:34 INFO - PROCESS | 23930 | RSS: Main: 222228480 08:25:34 INFO - PROCESS | 23930 | 08:28:37 INFO - PROCESS | 23930 | Cycle 1(1): loaded http://localhost:55903/tests/dromaeo/cssquery-yui.html (next: http://localhost:55903/tests/dromaeo/cssquery-dojo.html) 08:28:37 INFO - PROCESS | 23930 | RSS: Main: 267071488 08:28:37 INFO - PROCESS | 23930 | 08:28:37 INFO - PROCESS | 23930 | __start_tp_report 08:28:37 INFO - PROCESS | 23930 | _x_x_mozilla_page_load 08:28:37 INFO - PROCESS | 23930 | _x_x_mozilla_page_load_details 08:28:37 INFO - PROCESS | 23930 | |i|pagename|runs| 08:28:37 INFO - PROCESS | 23930 | |0;dojo.html;3049.9085027449178;3097.7521798256143;3123.141136187548;3135.9059228223146;3163.9050828475147;5222.164453687411;5344.438833922436;5366.141417373221;5376.193570964352;5377.354717433904;5381.704006279653;5427.592930530216;5436.836894893159;5458.972705136469;5489.615726899118;4875.098106850226;4878.097551952891;4890.290907818364;4903.803847846082;5041.798328066873;4982.252662100677;5008.29883816266;5050.646454748169;5058.2412638104215;5070.72111033893;4760.7619619018915;4841.225403935371;4880.682755620909;4892.0705066037335;4947.8020879164615;4877.6341774367065;4883.780229889628;4888.340074089988;4915.803367865316;4928.975355123237;4684.203685373494;4767.189577771787;4860.173770458995;4861.708297502161;4931.605471562267;5264.473552644705;5315.495027972336;5324.1747529133045;5328.6269961102735;5343.038253114438;5793.420657934215;5813.040848260032;5817.56368272377;5842.4741773240185;5862.179294898718;5793.362730099686;5799.797007104773;5803.53571714266;5805.129230615399;5805.912911306334;5190.532852043334;5333.893322133536;5400.945990540084;5419.864503387407;5422.864428389322;5875.41245875409;5888.499477544371;5889.440503152194;5890.558208134407;5899.115132730125;5642.774289028393;5648.237487939075;5680.233168522279;5737.5983681141915;5751.85620359486;5558.833235002957;5747.827565173052;5763.135529670583;5806.912896306559;5812.505936995318;5642.943570564324;5650.491455769001;5652.180433837153;5652.491275785199;5747.770089196469;5654.264945557134;5656.490915817596;5665.518430933417;5666.121751128581;5671.602987790898;4224.957750422518;4310.159518893848;4312.331588603772;4318.30907054876;4342.435483387139;3852.9807350963624;3868.129670824042;3873.4383514390256;3926.3521518949055;3952.9011774705286;5414.8917021659345;5420.593455490775;5420.891582168335;5424.864378390493;5456.699881506555;5787.276590426197;5816.331121921034;5842.912356314659;5846;5851.414858514115;5223.268742376071;5331.09371406854;5380.596455265871;5415.864603384947;5426.240326354314;4982.078315511642;4984.352034235599;4987.351644286219;4990.201567749143;5030.7233102179;5972.492338151219;5977.820665380045;5977.910331345033;5978.432048955342;5979.402059793986;5565.0817615093865;5730.140478928194;5786.450287222707;5828.358880523224;5833.358330583717;5922.022866227197;5926.348101708722;5927.407259274038;5936.554758393051;5941.1385349125;5448.4006759257245;5652.123920792284;5656.066748986371;5659.066254068032;5662.7734890603915;5724.4275572444085;5786.450287222707;5790.160426738184;5823.388544202967;5849.824505264849;5598.076317407582;5634.859128521656;5635.9436405635415;5646.745896434588;5650.63270887391;5386.542143917811;5535;5588.133839254922;5598.3282006159525;5632.239647647515;5528.9723551381985;5530.806421775219;5536.2249285100925;5547.944520554743;5579.218909352775;5619.971900140473;5636.351819540805;5662.546996240373;5662.971685141548;5666.206731057738;5328.094223981855;5507.752151153128;5522.116461366162;5543.36251331086;5614.101743720985 08:28:37 INFO - PROCESS | 23930 | |1;ext.html;555.1869487159474;577.3216470646988;579.0561384942544;595.4878804228366;600.7476859718917;39943.40084898725;40549.79725101378;40594;40622.18755624886;40622.79688601553;42063.36904946428;42102.57897421025;42414.7879260604;42482.575174248246;42539.14921701564;8801.383903126767;8957.19385255327;8978.281737460988;8986.775330616721;8988.910110898873;8804.603792829306;8909.287257019456;8925.95537022314;8926.419782714103;8928.955355223216;9206.723798286028;9290.442573445582;9296.070392960684;9296.256299496057;9300.20948219402;9120.452772833618;9186.632534698603;9203.401778884385;9205.079492050809;9205.447673139566;8938.329625278131;9037.502937338444;9059.456432614064;9063.59213835379;9065.864012039825;43563.346549801776;43658.563414365766;44021.33967990483;44025.55974440247;44048.339274910584;3440.3119376124873;3515.8417871195857;3535.027867336503;3536.8938931832085;3558.804265765382;33071.173220669436;33127;33457.16357091068;33626.49560256598;34053.659463405296;4270.466191726035;4277.807498662536;4334.631556317717;4379.824807007716;4423.336499525065;330505;334284.328578358;335106;337051;337612;60643;61252;61846;61893.381066189664;61900.69049654723;69729;70366.64816675884;70622.2937770626;70671;70695.2930470699;16178.75731864023;16395.098269595048;16408.097554634373;16408.507744767678;16409.507714768577;12253;12406.875931240753;12440.440180191914;12441.93779031099;12444.626661200178;21227.89386053091;21229.893850530647;21453.89273053625;21480.140794368363;22340.664890026663;8321.500709957421;8464.280536154372;8475.364347673949;8479.236868681848;8593.871091933626;1056.3081181825917;1090.7382228265317;1125.189863298424;1131.9943400282946;1133.195431243826;32536.186595335304;33121.83439082837;33268.66731332656;33341.16647083794;33709.32581348409;1162.2968104296947;1174.988250117505;1187.2935603316014;1192.4574318684977;1264.8355713757337;16609.6678066438;17287.222075006655;17390;18294.90852545729;18372.724409133873;227722;228705;229392;229749;230928;60335.396646033856;61942;61957.38042619516;61958.69020654868;61983;1244.2534479312521;1325.5360623781407;1327.0312671749678;1422.1893520693106;1453.6626303800529;30884;33471.49792753062;33793;34683.653163469055;34887.825560872036;54999;55874.72062639661;56132.15801763059;56234;56261.718691406284;369106;369691;369843;369860;370685;31130.688693113683;36766.816165919;37009.25981480409;37125.257494849415;37424;41614.1677166461;42238.788806055774;46464;47165.52834471611;47644.7617761909;39272.607273928035;39471.21057578775;39606.603933960294;39648;39730.80134599309;38304.2339153221;39084.413733793444;39382.21235575215;39457.2108557833;40208.97387826522;39990.80004599958;40677.38983915303;40931.795341023106;41243.587564123976;41321.380179296735;32757.508637370935;35190.12024699403;35372.469412958315;35416.64583354237;35645;27283.090183686953;27713;27859.72140278571;27864;27961 08:28:37 INFO - PROCESS | 23930 | |2;jquery.html;355.9697425718814;358.4640961762165;364.4897143998402;368.2120262637955;370.8331250937079;17605.119744012794;18116.90941545292;19703.605927881435;19721.90139049306;19726;18146.727799083023;18222.180001899913;19026.52433689155;19057.237710491598;19057.80942190578;5570.080936645459;5664.348599911022;5676.886462270752;5712.77148914045;5731.770729170849;4087.264292427362;5641.68970706611;5937.643741375509;6159.10692949522;6188.876222475547;6237.126802247689;6261.686915654199;6264.906026409585;6270.122182894398;6285.434310912017;6022.488088512482;6149.631022138686;6150.907736383958;6156.6921653917125;6239.532035097386;3645.6901163401144;5225.817096401608;5432.565394768449;5434.076207044812;5477.643953143033;20996.5800683987;21095.261665841623;21212;23000.884995574914;23025.309240722807;2383.6305372667266;2554.3997160667227;2576.6779152605923;2803.5374163263036;2877.338212211182;13854.376553055137;13978.440862365493;14154;14353.210573418457;14682.265886705622;1962.0876292523901;2011.989940050305;2032.1566549881782;2045.3530491738172;2056.5886822635384;71798;72971.27028729698;72977.63511182464;73338;73549;9959.502024898726;10078.14335781452;10099.646512372032;10174.440405777605;10219.23355748307;12522.248665080124;12786.424610892533;12791;12797.616071517868;12809.61571152867;7566.962165189138;7572.432067594952;7689.505646123066;7743.45795794289;7801.141874393812;7311.3785328247695;7437.1447283562;7495.700171993169;7516.47384683067;7532.322091011835;6347.746090156435;6451.645159516272;6457.967710161419;6458.2895881453005;6519.217693876765;1641.351666091887;1732.462936489667;1742.7995780485153;1743.9128043597768;1766.823317668223;1035.6634093919506;1048.5753269925692;1052.6684094510206;1073.22381458686;1073.4847273308856;17641;18193.818061819213;18250;18378.448646540626;19183.232670693294;1022.1414012229762;1030.2633616963906;1033.7260625934134;1072.7747173093737;1105.3588918427292;10446.268761186797;10746.516406761715;10911.399873006902;11077.889221107847;11167.162462815322;494631;504069;506556;506655;509052;91905.54047229855;92085;92268;92582.53708731414;94019.52990235006;1081.329575663094;1091.6561283195767;1102.2174256278133;1106.976047156377;1110.2394859521253;16708.16459177012;16710.832891671413;16767.832321676626;16835.326586936386;17129.914350428167;39714;39805.60194398019;40320.596794032856;40863;41384.58615413928;55452.16821747758;55516;55533.72233138808;55743.72128139334;55774.44225557693;8354.832903342021;8397.202265784741;8438;8461.40770146084;8533.957330213558;11581.768364632828;12935.482580696667;13086.803697944348;13168.80246796318;13274.469021239041;11207;11317.264377815416;11532.308061516336;11541.82687259675;11566.190366674253;11182.329060256085;11354.602588909349;11390.658280251606;11492.827607585725;11749.353785541878;11314.377709226072;11379.601713939972;11914.459776204107;11916.046716262505;12037;8316.459430137022;8403.327733781161;8453.873191902003;8474.449160804528;8515.19105684959;10616.575336986434;11706.76586468283;11776.11679124052;11887.227330223508;11924.76150477003 08:28:37 INFO - PROCESS | 23930 | |3;mootools.html;1329.980050299245;1554.4015554011705;1558;1796.7394727764474;1923.384516954574;8115.107338192802;8275.337972962163;8361.707340243092;8362.540060296682;8368.58157092146;8187.304079153264;8358.91641083589;8360.623771930263;8385.538795366252;8390.958045209765;2066.4214020074405;2316.050419328076;2342.039763696876;2359.0210062823908;2406.4585468269674;2368.4078980254935;2372.0748907925836;2372.8694921779297;2375.1449478187837;2375.4536456614987;2229.3646310801423;2318.6058370077126;2320.5126923346033;2324.1981516376823;2327.592671282527;2322.6516022596575;2327.9418014549688;2328.860268383902;2337.392278007722;2411.8311718179734;2359.1153317505937;2387.904483820645;2391.497785465054;2392.7966122879575;2392.964105538418;8159.184081591853;8244.8351032979;8249.876251856227;8253.752387428387;8254.339652827759;5143.974280128613;5293.86765330866;5299.894002119974;5300.681959082429;5305.73471326436;3315.287213249163;3345.063382252973;3386.407378708741;3509.982450087759;3518.753687241894;1047.7799662070975;1050.5482642463737;1066.4081434803682;1068.8824229334766;1087.0434018064052;11821.645350639494;11828.52685892572;11831.645050648494;11872.940635296769;11885.286882786973;4667.13657973276;4675.555822196886;4727.64542659302;4740.976295118571;4765.833195838129;9543.522823858779;9597.472139032281;9605.13553780163;9610.375325603813;9614.855777163348;4637.86086417408;5299.788008479618;5332.173513105475;5341.759620817073;5348.518633322942;4782.258749893772;4792.2332426811545;4856.2958371036;4870.05034018363;4877.097736918681;3904.570497245301;3942.3100957332354;3958;4007.8196481158416;4036.6367026967714;1196.5512932650256;1201.225209739713;1206.2280140709952;1213.4842691855927;1241.3234787041085;1187.1808452167977;1190.892819646236;1209.661294837447;1427.643089227693;1444.5377479206552;7828.452008359474;7912.881306780403;8014.358851291882;8016;8017.919820801834;484.1720657675414;493.948135445773;499.094144128413;503.7531609511313;504.9368828896388;5880.206172166702;5912.260967379078;5932.406759324033;5957.017092179742;5969.671668058299;9939.304248702521;10548.578056877639;10578.312409693346;10693.679189624168;10698.572057117628;10273;10535.683929482127;10570.2600817942;10572.52423640938;10611.681649550526;8102.432829701865;8174.3460523158;8207.056188538276;8255.380846436541;8266.090730019692;7847.529148251123;7874.094479134744;7906.7627971160955;7919.485233459806;7986.600669966595;8938.50838203905;9271.953640231755;9501.239900807781;9703.514824258618;9745.463999480096;9255.120763527455;9397.389169703947;9426.95286523563;9462.479563624067;9592.08875156859;6449.677516124269;7365.8526829462035;7478.588677622783;7610.847783044419;7716.691332346868;8035.276825085771;8036.236557527026;8043.477173983672;8071.677132914852;8086.676532938616;7152.642367881481;7157.821054473679;7308;7409.962950185431;7446.069241344832;7243.384312333511;7255.2019277878335;7259.52813067149;7264.854702905806;7354.485186036926;7432.814179645336;7454.105507338937;7505.099388073466;7510.586917719578;7516.285952834472;6969;6995.230524642184;6997.300269972962;6997.895031574429;7004.684789184601;6709.194896612243;6808.897866532105;6824.522283440111;6835.829104272433;6840.247572767091 08:28:37 INFO - PROCESS | 23930 | |4;prototype.html;342.09686427830525;343.8951119908427;344.51939544335636;344.8879114287857;352.69844283137917;5987.4910632596175;6035.3964603539625;6070.69646517674;6088.117223002668;6090.269167699877;6003.789867354643;6017.789377371793;6033.155358249848;6050.8184754457325;6052.092186172076;4441.977790111045;4556.635469162476;4638.397008388904;4655.953440465594;4687.320338550908;4664.323673067403;4664.720116793003;4675.789589468465;4676.55572720591;4680.087382960324;4608.5161058088925;4615.307703844416;4616.492185859553;4625.8149674013;4640.419947506562;4420.77896105195;4513.661475389343;4619.006913513611;4634.976825115887;4635.860924172281;4044.8179831907637;4063.6952228582973;4065.24792913309;4069.04377471294;4073.450084238649;5788.8842223155725;5790.160426738099;5791.82624521265;5798.449147330997;5813.273340832396;5346.812861549827;5354.143337066051;5361;5361.276227709287;5365.865853353658;6231.657258850807;6292.905606415908;6295.716692748837;6297.527685423612;6305.464035556983;4393.780310984438;4491.888812258266;4494.775261236958;4499.280115181556;4502.234620114588;6608.504362172808;6617.37134972172;6617.371349721769;6625.966870165618;6645.3354664533645;4606.56237657422;4608.055348653518;4608.7556359782675;4611.123886461562;4611.216093264153;4647.279671650899;4648.372469716613;4649.976750116295;4652.790624421909;4656.278276867091;5286.682799032071;5323.973380133075;5328.706921119376;5331.466853314638;5336.439673834191;6223.222097237845;6345.904811427832;6382.32985536512;6401.327860574573;6440.291567927524;1578.1399137470107;1584.7939767830107;1592.9920350398174;1593.6732969741174;1599.4561848971405;999.6501224571342;1047.5233768635253;1053.510117795229;1074.215822449616;1089.1395797320188;5962.4633782959745;5978.1929439525975;5979.402059794073;5981.850453738692;5984;6524.347565243533;6561.40947314744;6563.606183628997;6567.244766851778;6567.770128045496;6026.005709057957;6027.186329845415;6032.668203248776;6033.336333003366;6040.6979651018155;3459.100633835221;3494.3884820156372;3497.877574284939;3498.8075655838666;3499.61504234534;6610.636414997221;6698.933010669928;6773.966130169416;6782.084418603524;6853.17761868579;6750.291219421988;6756.2568117507035;6762.69567869447;6763.154605674291;6764.5603035802515;6834.931650683529;6836.38472537474;6842.110525631636;6845.007473916255;6849.315068493111;6610.3720146586;6615.900761488678;6619.669016549057;6620.5034622402545;6631.734730610721;6388.39310265524;6565.737370505126;6572.539922205399;6580.243272023587;6590.077389165424;6829.556078854858;6853.00631408433;6858.965705171442;6862.451003919575;6868.759593414206;4475.9328610071525;4498.865034048984;4504.121696269196;4508.977455112704;4511.5262897395305;6576.2766095728475;6577.408033277028;6594.901076483952;6598.472122230114;6615.6030638161865;6160.322364539987;6388.361163883575;6419.64691941929;6425.742970281136;6457.225132984072;6361.332060133805;6402.87194256103;6410.358964103552;6420.6468644225015;6425.389587989133;6310.873782524415;6317.147185129948;6324.936750632435;6326.810195694136;6326.841828954313;6446.67766611677;6461.289258181502;6461.838454038687;6461.967690161519;6472.15861937945;5994.31065427464;6095.96368617345;6227.4395304421005;6289.559730818982;6292.244930608356 08:28:37 INFO - PROCESS | 23930 | |5;yui.html;791.2206476620528;830.269362960595;871.821276638289;876.3996662286335;903.0608167505794;15088.396464141435;15265.465708700198;15270.847291527096;15280.54158375249;15281.541553753377;14246.715065698705;14291.928540357283;14304.71390572188;14315;14333.713325733479;698.4377576051277;850.3324889961382;866.5840396609631;869.2394155114275;870.9129087091303;841.7769291137853;864.9091845356241;867.1588559097665;872.8210716803072;872.9301655867515;887.2901678657081;917.7338571814166;920.4293338130368;921.3918813583036;921.787988762585;737.5169264131976;902.634433054614;914.1909410171979;915.3226612306911;916.1800188831025;638.3680156644934;651.6090345792487;661.3518751623388;667.6428110960612;668.812732434919;13705.862941370558;13709.245991470465;13746;13763;13766.862331376758;14145.646358841008;14430.927845360811;14506.41974321026;14671.33978970949;14680.779788303184;11296.887031129665;11465.656030319104;11593.826092608617;11680.824787628193;11756.529738810437;3850.7304488685804;3872.7289089763726;3936.566977632458;3950.249452603996;3973.443717879499;55077.72461137669;55141;55231;55414.44585554133;55521.72239138778;10600.893991059991;10891.945540272249;11006.559737610405;11315.321080735182;11322.830157547643;19921.402357929284;19991.60016799656;20006.89996550037;20042.298519552038;20096.49758756043;8674;8674.175953284428;8699.695510657097;8758.2993360531;8805.207531322212;4833.975830120827;4891.55975962158;4983.277424773388;5039.4708555601865;5069.44236134025;3524.1013541547254;3561.5013898054294;3575.8390872410805;3584.7849129052343;3600.2979419013564;585.6017907822721;650.3334082565314;671.1744554198364;684.5345165287653;689.8896176611718;683.7641013850214;779.8323360477525;784.2667106255669;796.2197046894076;800.2917418085036;9255.213306868856;9877.950610246902;10015.849762253572;10027.548760305805;10036.447995360326;695.09984569982;743.8437928035065;762.6644276518314;797.0992778160758;828.6726742936506;4506.143832671782;4510.819567217274;4583.564561366665;4624.953750462452;4657.3246879202325;67153;67160.32839671639;67473;67556;67718.66140669363;56268.718656407276;58981.705091474265;59106.70446647739;59515;59551.404485955456;51261;51502.48497515052;52005.219921700445;52564.47435525596;52618.736906315986;9282;9302.581383837878;9307.72076837696;9392.154706076486;9404.764880878032;37911.62088379081;38146.046348841504;38648.42027369535;38744.418833716954;38857.41713874238;44787.104257914005;48254.75872620614;50924;51001;52157;11542.538298467967;11576.942115289707;11839.520059992501;12436.129470936947;12889.871101288867;13606.863931360956;14378.496752613608;14464.13215207091;14725.55823325302;15380.230988450756;13633.182009079486;13748.725025499634;13805.79291310611;14148.575542733735;14251.073680211168;13398.464061437433;13767.655808604464;13801.86198138046;13822.861771382157;14310;13699.589012329647;13764.105333153313;13791.724165516835;13859.029867909552;13960;9937.850932236166;9968.352057116264;9977.151942085004;10100.797984040424;10760.946195268974;10732.517036733521;10874.565017399216;10967.945160274467;10992;11001.339919604849 08:28:37 INFO - PROCESS | 23930 | __end_tp_report 08:28:37 INFO - PROCESS | 23930 | __start_cc_report 08:28:37 INFO - PROCESS | 23930 | _x_x_mozilla_cycle_collect,861 08:28:37 INFO - PROCESS | 23930 | __end_cc_report 08:28:37 INFO - PROCESS | 23930 | __startTimestamp1458055717316__endTimestamp 08:28:37 INFO - PROCESS | 23930 | 08:28:37 INFO - PROCESS | 23930 | ------- Summary: start ------- 08:28:37 INFO - PROCESS | 23930 | Number of tests: 6 08:28:37 INFO - PROCESS | 23930 | 08:28:37 INFO - PROCESS | 23930 | [#0] dojo.html Cycles:165 Average:5337.03 Median:5535.00 stddev:612.19 (11.1%) stddev-sans-first:587.19 08:28:37 INFO - PROCESS | 23930 | Values: 3049.9 3097.8 3123.1 3135.9 3163.9 5222.2 5344.4 5366.1 5376.2 5377.4 5381.7 5427.6 5436.8 5459.0 5489.6 4875.1 4878.1 4890.3 4903.8 5041.8 4982.3 5008.3 5050.6 5058.2 5070.7 4760.8 4841.2 4880.7 4892.1 4947.8 4877.6 4883.8 4888.3 4915.8 4929.0 4684.2 4767.2 4860.2 4861.7 4931.6 5264.5 5315.5 5324.2 5328.6 5343.0 5793.4 5813.0 5817.6 5842.5 5862.2 5793.4 5799.8 5803.5 5805.1 5805.9 5190.5 5333.9 5400.9 5419.9 5422.9 5875.4 5888.5 5889.4 5890.6 5899.1 5642.8 5648.2 5680.2 5737.6 5751.9 5558.8 5747.8 5763.1 5806.9 5812.5 5642.9 5650.5 5652.2 5652.5 5747.8 5654.3 5656.5 5665.5 5666.1 5671.6 4225.0 4310.2 4312.3 4318.3 4342.4 3853.0 3868.1 3873.4 3926.4 3952.9 5414.9 5420.6 5420.9 5424.9 5456.7 5787.3 5816.3 5842.9 5846.0 5851.4 5223.3 5331.1 5380.6 5415.9 5426.2 4982.1 4984.4 4987.4 4990.2 5030.7 5972.5 5977.8 5977.9 5978.4 5979.4 5565.1 5730.1 5786.5 5828.4 5833.4 5922.0 5926.3 5927.4 5936.6 5941.1 5448.4 5652.1 5656.1 5659.1 5662.8 5724.4 5786.5 5790.2 5823.4 5849.8 5598.1 5634.9 5635.9 5646.7 5650.6 5386.5 5535.0 5588.1 5598.3 5632.2 5529.0 5530.8 5536.2 5547.9 5579.2 5620.0 5636.4 5662.5 5663.0 5666.2 5328.1 5507.8 5522.1 5543.4 5614.1 08:28:37 INFO - PROCESS | 23930 | 08:28:37 INFO - PROCESS | 23930 | [#1] ext.html Cycles:180 Average:50204.23 Median:39538.91 stddev:83057.42 (210.1%) stddev-sans-first:83206.76 08:28:37 INFO - PROCESS | 23930 | Values: 555.2 577.3 579.1 595.5 600.7 39943.4 40549.8 40594.0 40622.2 40622.8 42063.4 42102.6 42414.8 42482.6 42539.1 8801.4 8957.2 8978.3 8986.8 8988.9 8804.6 8909.3 8926.0 8926.4 8929.0 9206.7 9290.4 9296.1 9296.3 9300.2 9120.5 9186.6 9203.4 9205.1 9205.4 8938.3 9037.5 9059.5 9063.6 9065.9 43563.3 43658.6 44021.3 44025.6 44048.3 3440.3 3515.8 3535.0 3536.9 3558.8 33071.2 33127.0 33457.2 33626.5 34053.7 4270.5 4277.8 4334.6 4379.8 4423.3 330505.0 334284.3 335106.0 337051.0 337612.0 60643.0 61252.0 61846.0 61893.4 61900.7 69729.0 70366.6 70622.3 70671.0 70695.3 16178.8 16395.1 16408.1 16408.5 16409.5 12253.0 12406.9 12440.4 12441.9 12444.6 21227.9 21229.9 21453.9 21480.1 22340.7 8321.5 8464.3 8475.4 8479.2 8593.9 1056.3 1090.7 1125.2 1132.0 1133.2 32536.2 33121.8 33268.7 33341.2 33709.3 1162.3 1175.0 1187.3 1192.5 1264.8 16609.7 17287.2 17390.0 18294.9 18372.7 227722.0 228705.0 229392.0 229749.0 230928.0 60335.4 61942.0 61957.4 61958.7 61983.0 1244.3 1325.5 1327.0 1422.2 1453.7 30884.0 33471.5 33793.0 34683.7 34887.8 54999.0 55874.7 56132.2 56234.0 56261.7 369106.0 369691.0 369843.0 369860.0 370685.0 31130.7 36766.8 37009.3 37125.3 37424.0 41614.2 42238.8 46464.0 47165.5 47644.8 39272.6 39471.2 39606.6 39648.0 39730.8 38304.2 39084.4 39382.2 39457.2 40209.0 39990.8 40677.4 40931.8 41243.6 41321.4 32757.5 35190.1 35372.5 35416.6 35645.0 27283.1 27713.0 27859.7 27864.0 27961.0 08:28:37 INFO - PROCESS | 23930 | 08:28:37 INFO - PROCESS | 23930 | [#2] jquery.html Cycles:180 Average:29012.26 Median:21153.63 stddev:82915.33 (392.0%) stddev-sans-first:83120.01 08:28:37 INFO - PROCESS | 23930 | Values: 356.0 358.5 364.5 368.2 370.8 17605.1 18116.9 19703.6 19721.9 19726.0 18146.7 18222.2 19026.5 19057.2 19057.8 5570.1 5664.3 5676.9 5712.8 5731.8 4087.3 5641.7 5937.6 6159.1 6188.9 6237.1 6261.7 6264.9 6270.1 6285.4 6022.5 6149.6 6150.9 6156.7 6239.5 3645.7 5225.8 5432.6 5434.1 5477.6 20996.6 21095.3 21212.0 23000.9 23025.3 2383.6 2554.4 2576.7 2803.5 2877.3 13854.4 13978.4 14154.0 14353.2 14682.3 1962.1 2012.0 2032.2 2045.4 2056.6 71798.0 72971.3 72977.6 73338.0 73549.0 9959.5 10078.1 10099.6 10174.4 10219.2 12522.2 12786.4 12791.0 12797.6 12809.6 7567.0 7572.4 7689.5 7743.5 7801.1 7311.4 7437.1 7495.7 7516.5 7532.3 6347.7 6451.6 6458.0 6458.3 6519.2 1641.4 1732.5 1742.8 1743.9 1766.8 1035.7 1048.6 1052.7 1073.2 1073.5 17641.0 18193.8 18250.0 18378.4 19183.2 1022.1 1030.3 1033.7 1072.8 1105.4 10446.3 10746.5 10911.4 11077.9 11167.2 494631.0 504069.0 506556.0 506655.0 509052.0 91905.5 92085.0 92268.0 92582.5 94019.5 1081.3 1091.7 1102.2 1107.0 1110.2 16708.2 16710.8 16767.8 16835.3 17129.9 39714.0 39805.6 40320.6 40863.0 41384.6 55452.2 55516.0 55533.7 55743.7 55774.4 8354.8 8397.2 8438.0 8461.4 8534.0 11581.8 12935.5 13086.8 13168.8 13274.5 11207.0 11317.3 11532.3 11541.8 11566.2 11182.3 11354.6 11390.7 11492.8 11749.4 11314.4 11379.6 11914.5 11916.0 12037.0 8316.5 8403.3 8453.9 8474.4 8515.2 10616.6 11706.8 11776.1 11887.2 11924.8 08:28:37 INFO - PROCESS | 23930 | 08:28:37 INFO - PROCESS | 23930 | [#3] mootools.html Cycles:180 Average:5894.36 Median:5318.95 stddev:3141.45 (59.1%) stddev-sans-first:3131.53 08:28:37 INFO - PROCESS | 23930 | Values: 1330.0 1554.4 1558.0 1796.7 1923.4 8115.1 8275.3 8361.7 8362.5 8368.6 8187.3 8358.9 8360.6 8385.5 8391.0 2066.4 2316.1 2342.0 2359.0 2406.5 2368.4 2372.1 2372.9 2375.1 2375.5 2229.4 2318.6 2320.5 2324.2 2327.6 2322.7 2327.9 2328.9 2337.4 2411.8 2359.1 2387.9 2391.5 2392.8 2393.0 8159.2 8244.8 8249.9 8253.8 8254.3 5144.0 5293.9 5299.9 5300.7 5305.7 3315.3 3345.1 3386.4 3510.0 3518.8 1047.8 1050.5 1066.4 1068.9 1087.0 11821.6 11828.5 11831.6 11872.9 11885.3 4667.1 4675.6 4727.6 4741.0 4765.8 9543.5 9597.5 9605.1 9610.4 9614.9 4637.9 5299.8 5332.2 5341.8 5348.5 4782.3 4792.2 4856.3 4870.1 4877.1 3904.6 3942.3 3958.0 4007.8 4036.6 1196.6 1201.2 1206.2 1213.5 1241.3 1187.2 1190.9 1209.7 1427.6 1444.5 7828.5 7912.9 8014.4 8016.0 8017.9 484.2 493.9 499.1 503.8 504.9 5880.2 5912.3 5932.4 5957.0 5969.7 9939.3 10548.6 10578.3 10693.7 10698.6 10273.0 10535.7 10570.3 10572.5 10611.7 8102.4 8174.3 8207.1 8255.4 8266.1 7847.5 7874.1 7906.8 7919.5 7986.6 8938.5 9272.0 9501.2 9703.5 9745.5 9255.1 9397.4 9427.0 9462.5 9592.1 6449.7 7365.9 7478.6 7610.8 7716.7 8035.3 8036.2 8043.5 8071.7 8086.7 7152.6 7157.8 7308.0 7410.0 7446.1 7243.4 7255.2 7259.5 7264.9 7354.5 7432.8 7454.1 7505.1 7510.6 7516.3 6969.0 6995.2 6997.3 6997.9 7004.7 6709.2 6808.9 6824.5 6835.8 6840.2 08:28:37 INFO - PROCESS | 23930 | 08:28:37 INFO - PROCESS | 23930 | [#4] prototype.html Cycles:180 Average:5342.04 Median:6032.91 stddev:1607.59 (26.6%) stddev-sans-first:1567.69 08:28:37 INFO - PROCESS | 23930 | Values: 342.1 343.9 344.5 344.9 352.7 5987.5 6035.4 6070.7 6088.1 6090.3 6003.8 6017.8 6033.2 6050.8 6052.1 4442.0 4556.6 4638.4 4656.0 4687.3 4664.3 4664.7 4675.8 4676.6 4680.1 4608.5 4615.3 4616.5 4625.8 4640.4 4420.8 4513.7 4619.0 4635.0 4635.9 4044.8 4063.7 4065.2 4069.0 4073.5 5788.9 5790.2 5791.8 5798.4 5813.3 5346.8 5354.1 5361.0 5361.3 5365.9 6231.7 6292.9 6295.7 6297.5 6305.5 4393.8 4491.9 4494.8 4499.3 4502.2 6608.5 6617.4 6617.4 6626.0 6645.3 4606.6 4608.1 4608.8 4611.1 4611.2 4647.3 4648.4 4650.0 4652.8 4656.3 5286.7 5324.0 5328.7 5331.5 5336.4 6223.2 6345.9 6382.3 6401.3 6440.3 1578.1 1584.8 1593.0 1593.7 1599.5 999.7 1047.5 1053.5 1074.2 1089.1 5962.5 5978.2 5979.4 5981.9 5984.0 6524.3 6561.4 6563.6 6567.2 6567.8 6026.0 6027.2 6032.7 6033.3 6040.7 3459.1 3494.4 3497.9 3498.8 3499.6 6610.6 6698.9 6774.0 6782.1 6853.2 6750.3 6756.3 6762.7 6763.2 6764.6 6834.9 6836.4 6842.1 6845.0 6849.3 6610.4 6615.9 6619.7 6620.5 6631.7 6388.4 6565.7 6572.5 6580.2 6590.1 6829.6 6853.0 6859.0 6862.5 6868.8 4475.9 4498.9 4504.1 4509.0 4511.5 6576.3 6577.4 6594.9 6598.5 6615.6 6160.3 6388.4 6419.6 6425.7 6457.2 6361.3 6402.9 6410.4 6420.6 6425.4 6310.9 6317.1 6324.9 6326.8 6326.8 6446.7 6461.3 6461.8 6462.0 6472.2 5994.3 6096.0 6227.4 6289.6 6292.2 08:28:37 INFO - PROCESS | 23930 | 08:28:37 INFO - PROCESS | 23930 | [#5] yui.html Cycles:180 Average:15636.41 Median:26456.04 stddev:18202.29 (68.8%) stddev-sans-first:18219.21 08:28:37 INFO - PROCESS | 23930 | Values: 791.2 830.3 871.8 876.4 903.1 15088.4 15265.5 15270.8 15280.5 15281.5 14246.7 14291.9 14304.7 14315.0 14333.7 698.4 850.3 866.6 869.2 870.9 841.8 864.9 867.2 872.8 872.9 887.3 917.7 920.4 921.4 921.8 737.5 902.6 914.2 915.3 916.2 638.4 651.6 661.4 667.6 668.8 13705.9 13709.2 13746.0 13763.0 13766.9 14145.6 14430.9 14506.4 14671.3 14680.8 11296.9 11465.7 11593.8 11680.8 11756.5 3850.7 3872.7 3936.6 3950.2 3973.4 55077.7 55141.0 55231.0 55414.4 55521.7 10600.9 10891.9 11006.6 11315.3 11322.8 19921.4 19991.6 20006.9 20042.3 20096.5 8674.0 8674.2 8699.7 8758.3 8805.2 4834.0 4891.6 4983.3 5039.5 5069.4 3524.1 3561.5 3575.8 3584.8 3600.3 585.6 650.3 671.2 684.5 689.9 683.8 779.8 784.3 796.2 800.3 9255.2 9878.0 10015.8 10027.5 10036.4 695.1 743.8 762.7 797.1 828.7 4506.1 4510.8 4583.6 4625.0 4657.3 67153.0 67160.3 67473.0 67556.0 67718.7 56268.7 58981.7 59106.7 59515.0 59551.4 51261.0 51502.5 52005.2 52564.5 52618.7 9282.0 9302.6 9307.7 9392.2 9404.8 37911.6 38146.0 38648.4 38744.4 38857.4 44787.1 48254.8 50924.0 51001.0 52157.0 11542.5 11576.9 11839.5 12436.1 12889.9 13606.9 14378.5 14464.1 14725.6 15380.2 13633.2 13748.7 13805.8 14148.6 14251.1 13398.5 13767.7 13801.9 13822.9 14310.0 13699.6 13764.1 13791.7 13859.0 13960.0 9937.9 9968.4 9977.2 10100.8 10760.9 10732.5 10874.6 10967.9 10992.0 11001.3 08:28:37 INFO - PROCESS | 23930 | -------- Summary: end -------- 08:28:37 INFO - PROCESS | 23930 | 08:28:38 INFO - TEST-INFO | 23930: exit 0 08:28:38 INFO - TEST-OK | dromaeo_css | took 1194525ms 08:28:38 INFO - TEST-START | kraken 08:28:38 INFO - operating with platform_type : linux_ 08:28:38 INFO - Initialising browser for kraken test... 08:28:38 INFO - TEST-INFO | started process 24116 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxnp6JK/profile http://localhost:55903/getInfo.html) 08:28:52 INFO - PROCESS | 24116 | __metrics Screen width/height:1600/1200 08:28:52 INFO - PROCESS | 24116 | colorDepth:24 08:28:52 INFO - PROCESS | 24116 | Browser inner width/height: 1024/697 08:28:52 INFO - PROCESS | 24116 | __metrics 08:28:58 ERROR - PROCESS | 24116 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:28:59 INFO - TEST-INFO | 24116: exit 0 08:28:59 INFO - Browser initialized. 08:28:59 INFO - Running cycle 1/1 for kraken test... 08:28:59 INFO - TEST-INFO | started process 24200 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxnp6JK/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:29:11 INFO - PROCESS | 24200 | RSS: Main: 155844608 08:29:11 INFO - PROCESS | 24200 | 08:29:14 INFO - PROCESS | 24200 | Cycle 1(1): loaded http://localhost:55903/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55903/tests/kraken/driver.html?testName=audio-beat-detection) 08:29:14 INFO - PROCESS | 24200 | RSS: Main: 199294976 08:29:14 INFO - PROCESS | 24200 | 08:29:17 INFO - PROCESS | 24200 | Cycle 1(1): loaded http://localhost:55903/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55903/tests/kraken/driver.html?testName=audio-dft) 08:29:17 INFO - PROCESS | 24200 | RSS: Main: 189517824 08:29:17 INFO - PROCESS | 24200 | 08:29:20 INFO - PROCESS | 24200 | Cycle 1(1): loaded http://localhost:55903/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55903/tests/kraken/driver.html?testName=audio-fft) 08:29:21 INFO - PROCESS | 24200 | RSS: Main: 171974656 08:29:21 INFO - PROCESS | 24200 | 08:29:23 INFO - PROCESS | 24200 | Cycle 1(1): loaded http://localhost:55903/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55903/tests/kraken/driver.html?testName=audio-oscillator) 08:29:23 INFO - PROCESS | 24200 | RSS: Main: 176660480 08:29:23 INFO - PROCESS | 24200 | 08:29:26 INFO - PROCESS | 24200 | Cycle 1(1): loaded http://localhost:55903/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55903/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:29:26 INFO - PROCESS | 24200 | RSS: Main: 176066560 08:29:26 INFO - PROCESS | 24200 | 08:29:29 INFO - PROCESS | 24200 | Cycle 1(1): loaded http://localhost:55903/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55903/tests/kraken/driver.html?testName=imaging-darkroom) 08:29:30 INFO - PROCESS | 24200 | RSS: Main: 176783360 08:29:30 INFO - PROCESS | 24200 | 08:29:33 INFO - PROCESS | 24200 | Cycle 1(1): loaded http://localhost:55903/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55903/tests/kraken/driver.html?testName=imaging-desaturate) 08:29:34 INFO - PROCESS | 24200 | RSS: Main: 176205824 08:29:34 INFO - PROCESS | 24200 | 08:29:37 INFO - PROCESS | 24200 | Cycle 1(1): loaded http://localhost:55903/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55903/tests/kraken/driver.html?testName=json-parse-financial) 08:29:37 INFO - PROCESS | 24200 | RSS: Main: 176701440 08:29:37 INFO - PROCESS | 24200 | 08:29:39 INFO - PROCESS | 24200 | Cycle 1(1): loaded http://localhost:55903/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55903/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:29:40 INFO - PROCESS | 24200 | RSS: Main: 189149184 08:29:40 INFO - PROCESS | 24200 | 08:29:41 INFO - PROCESS | 24200 | Cycle 1(1): loaded http://localhost:55903/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55903/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:29:42 INFO - PROCESS | 24200 | RSS: Main: 184610816 08:29:42 INFO - PROCESS | 24200 | 08:29:44 INFO - PROCESS | 24200 | Cycle 1(1): loaded http://localhost:55903/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55903/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:29:45 INFO - PROCESS | 24200 | RSS: Main: 194797568 08:29:45 INFO - PROCESS | 24200 | 08:29:47 INFO - PROCESS | 24200 | Cycle 1(1): loaded http://localhost:55903/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55903/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:29:48 INFO - PROCESS | 24200 | RSS: Main: 200138752 08:29:48 INFO - PROCESS | 24200 | 08:29:50 INFO - PROCESS | 24200 | Cycle 1(1): loaded http://localhost:55903/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55903/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:29:51 INFO - PROCESS | 24200 | RSS: Main: 197713920 08:29:51 INFO - PROCESS | 24200 | 08:29:52 INFO - PROCESS | 24200 | Cycle 1(1): loaded http://localhost:55903/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55903/tests/kraken/driver.html?testName=ai-astar) 08:29:52 INFO - PROCESS | 24200 | RSS: Main: 256720896 08:29:52 INFO - PROCESS | 24200 | 08:29:52 INFO - PROCESS | 24200 | __start_tp_report 08:29:52 INFO - PROCESS | 24200 | _x_x_mozilla_page_load 08:29:52 INFO - PROCESS | 24200 | _x_x_mozilla_page_load_details 08:29:52 INFO - PROCESS | 24200 | |i|pagename|runs| 08:29:52 INFO - PROCESS | 24200 | |0;ai-astar;109;108;104;108;110;109;98;108;108;111 08:29:52 INFO - PROCESS | 24200 | |1;audio-beat-detection;153;125;148;180;126;149;153;123;169;124 08:29:52 INFO - PROCESS | 24200 | |2;audio-dft;161;161;161;162;159;161;161;163;161;161 08:29:52 INFO - PROCESS | 24200 | |3;audio-fft;72;75;91;97;75;75;74;105;91;75 08:29:52 INFO - PROCESS | 24200 | |4;audio-oscillator;93;92;150;92;93;93;146;91;92;142 08:29:52 INFO - PROCESS | 24200 | |5;imaging-gaussian-blur;116;117;117;118;118;117;117;117;118;117 08:29:52 INFO - PROCESS | 24200 | |6;imaging-darkroom;145;145;145;146;145;145;146;146;146;145 08:29:52 INFO - PROCESS | 24200 | |7;imaging-desaturate;96;95;96;96;96;95;95;96;95;96 08:29:52 INFO - PROCESS | 24200 | |8;json-parse-financial;57;55;55;55;55;55;56;59;57;57 08:29:52 INFO - PROCESS | 24200 | |9;json-stringify-tinderbox;61;61;60;60;61;61;61;59;60;61 08:29:52 INFO - PROCESS | 24200 | |10;stanford-crypto-aes;77;78;76;77;78;78;77;78;88;80 08:29:52 INFO - PROCESS | 24200 | |11;stanford-crypto-ccm;110;110;108;107;114;109;115;121;108;110 08:29:52 INFO - PROCESS | 24200 | |12;stanford-crypto-pbkdf2;138;138;138;136;140;141;137;139;139;137 08:29:52 INFO - PROCESS | 24200 | |13;stanford-crypto-sha256-iterative;64;62;64;63;62;63;63;61;62;61 08:29:52 INFO - PROCESS | 24200 | __end_tp_report 08:29:52 INFO - PROCESS | 24200 | __start_cc_report 08:29:52 INFO - PROCESS | 24200 | _x_x_mozilla_cycle_collect,1022 08:29:52 INFO - PROCESS | 24200 | __end_cc_report 08:29:52 INFO - PROCESS | 24200 | __startTimestamp1458055792929__endTimestamp 08:29:52 INFO - PROCESS | 24200 | 08:29:52 INFO - PROCESS | 24200 | ------- Summary: start ------- 08:29:52 INFO - PROCESS | 24200 | Number of tests: 14 08:29:52 INFO - PROCESS | 24200 | 08:29:52 INFO - PROCESS | 24200 | [#0] ai-astar Cycles:10 Average:107.30 Median:109.00 stddev:3.74 (3.4%) stddev-sans-first:3.92 08:29:52 INFO - PROCESS | 24200 | Values: 109.0 108.0 104.0 108.0 110.0 109.0 98.0 108.0 108.0 111.0 08:29:52 INFO - PROCESS | 24200 | 08:29:52 INFO - PROCESS | 24200 | [#1] audio-beat-detection Cycles:10 Average:145.00 Median:151.00 stddev:20.11 (13.3%) stddev-sans-first:21.12 08:29:52 INFO - PROCESS | 24200 | Values: 153.0 125.0 148.0 180.0 126.0 149.0 153.0 123.0 169.0 124.0 08:29:52 INFO - PROCESS | 24200 | 08:29:52 INFO - PROCESS | 24200 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.99 (0.6%) stddev-sans-first:1.05 08:29:52 INFO - PROCESS | 24200 | Values: 161.0 161.0 161.0 162.0 159.0 161.0 161.0 163.0 161.0 161.0 08:29:52 INFO - PROCESS | 24200 | 08:29:52 INFO - PROCESS | 24200 | [#3] audio-fft Cycles:10 Average:83.00 Median:75.00 stddev:11.86 (15.8%) stddev-sans-first:11.89 08:29:52 INFO - PROCESS | 24200 | Values: 72.0 75.0 91.0 97.0 75.0 75.0 74.0 105.0 91.0 75.0 08:29:52 INFO - PROCESS | 24200 | 08:29:52 INFO - PROCESS | 24200 | [#4] audio-oscillator Cycles:10 Average:108.40 Median:92.00 stddev:26.02 (28.3%) stddev-sans-first:27.00 08:29:52 INFO - PROCESS | 24200 | Values: 93.0 92.0 150.0 92.0 93.0 93.0 146.0 91.0 92.0 142.0 08:29:52 INFO - PROCESS | 24200 | 08:29:52 INFO - PROCESS | 24200 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.50 08:29:52 INFO - PROCESS | 24200 | Values: 116.0 117.0 117.0 118.0 118.0 117.0 117.0 117.0 118.0 117.0 08:29:52 INFO - PROCESS | 24200 | 08:29:52 INFO - PROCESS | 24200 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 08:29:52 INFO - PROCESS | 24200 | Values: 145.0 145.0 145.0 146.0 145.0 145.0 146.0 146.0 146.0 145.0 08:29:52 INFO - PROCESS | 24200 | 08:29:52 INFO - PROCESS | 24200 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 08:29:52 INFO - PROCESS | 24200 | Values: 96.0 95.0 96.0 96.0 96.0 95.0 95.0 96.0 95.0 96.0 08:29:52 INFO - PROCESS | 24200 | 08:29:52 INFO - PROCESS | 24200 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:56.50 stddev:1.37 (2.4%) stddev-sans-first:1.41 08:29:52 INFO - PROCESS | 24200 | Values: 57.0 55.0 55.0 55.0 55.0 55.0 56.0 59.0 57.0 57.0 08:29:52 INFO - PROCESS | 24200 | 08:29:52 INFO - PROCESS | 24200 | [#9] json-stringify-tinderbox Cycles:10 Average:60.50 Median:61.00 stddev:0.71 (1.2%) stddev-sans-first:0.73 08:29:52 INFO - PROCESS | 24200 | Values: 61.0 61.0 60.0 60.0 61.0 61.0 61.0 59.0 60.0 61.0 08:29:52 INFO - PROCESS | 24200 | 08:29:52 INFO - PROCESS | 24200 | [#10] stanford-crypto-aes Cycles:10 Average:78.70 Median:78.00 stddev:3.43 (4.4%) stddev-sans-first:3.59 08:29:52 INFO - PROCESS | 24200 | Values: 77.0 78.0 76.0 77.0 78.0 78.0 77.0 78.0 88.0 80.0 08:29:52 INFO - PROCESS | 24200 | 08:29:52 INFO - PROCESS | 24200 | [#11] stanford-crypto-ccm Cycles:10 Average:111.20 Median:110.00 stddev:4.29 (3.9%) stddev-sans-first:4.53 08:29:52 INFO - PROCESS | 24200 | Values: 110.0 110.0 108.0 107.0 114.0 109.0 115.0 121.0 108.0 110.0 08:29:52 INFO - PROCESS | 24200 | 08:29:52 INFO - PROCESS | 24200 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.30 Median:138.50 stddev:1.49 (1.1%) stddev-sans-first:1.58 08:29:52 INFO - PROCESS | 24200 | Values: 138.0 138.0 138.0 136.0 140.0 141.0 137.0 139.0 139.0 137.0 08:29:52 INFO - PROCESS | 24200 | 08:29:52 INFO - PROCESS | 24200 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.50 Median:63.00 stddev:1.08 (1.7%) stddev-sans-first:1.00 08:29:52 INFO - PROCESS | 24200 | Values: 64.0 62.0 64.0 63.0 62.0 63.0 63.0 61.0 62.0 61.0 08:29:52 INFO - PROCESS | 24200 | -------- Summary: end -------- 08:29:52 INFO - PROCESS | 24200 | 08:30:01 INFO - Browser shutdown timed out after 5 seconds, terminating process. 08:30:01 INFO - Terminating psutil.Process(pid=24200, name='firefox') 08:30:01 INFO - TEST-INFO | 24200: exit 15 08:30:01 INFO - TEST-OK | kraken | took 82661ms 08:30:01 INFO - SUITE-END | took 1277s 08:30:01 INFO - Completed test suite (00:21:17) 08:30:01 INFO - javascript benchmark 08:30:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3049.9085027449178, 3097.7521798256143, 3123.141136187548, 3135.9059228223146, 3163.9050828475147, 5222.164453687411, 5344.438833922436, 5366.141417373221, 5376.193570964352, 5377.354717433904, 5381.704006279653, 5427.592930530216, 5436.836894893159, 5458.972705136469, 5489.615726899118, 4875.098106850226, 4878.097551952891, 4890.290907818364, 4903.803847846082, 5041.798328066873, 4982.252662100677, 5008.29883816266, 5050.646454748169, 5058.2412638104215, 5070.72111033893, 4760.7619619018915, 4841.225403935371, 4880.682755620909, 4892.0705066037335, 4947.8020879164615, 4877.6341774367065, 4883.780229889628, 4888.340074089988, 4915.803367865316, 4928.975355123237, 4684.203685373494, 4767.189577771787, 4860.173770458995, 4861.708297502161, 4931.605471562267, 5264.473552644705, 5315.495027972336, 5324.1747529133045, 5328.6269961102735, 5343.038253114438, 5793.420657934215, 5813.040848260032, 5817.56368272377, 5842.4741773240185, 5862.179294898718, 5793.362730099686, 5799.797007104773, 5803.53571714266, 5805.129230615399, 5805.912911306334, 5190.532852043334, 5333.893322133536, 5400.945990540084, 5419.864503387407, 5422.864428389322, 5875.41245875409, 5888.499477544371, 5889.440503152194, 5890.558208134407, 5899.115132730125, 5642.774289028393, 5648.237487939075, 5680.233168522279, 5737.5983681141915, 5751.85620359486, 5558.833235002957, 5747.827565173052, 5763.135529670583, 5806.912896306559, 5812.505936995318, 5642.943570564324, 5650.491455769001, 5652.180433837153, 5652.491275785199, 5747.770089196469, 5654.264945557134, 5656.490915817596, 5665.518430933417, 5666.121751128581, 5671.602987790898, 4224.957750422518, 4310.159518893848, 4312.331588603772, 4318.30907054876, 4342.435483387139, 3852.9807350963624, 3868.129670824042, 3873.4383514390256, 3926.3521518949055, 3952.9011774705286, 5414.8917021659345, 5420.593455490775, 5420.891582168335, 5424.864378390493, 5456.699881506555, 5787.276590426197, 5816.331121921034, 5842.912356314659, 5846.0, 5851.414858514115, 5223.268742376071, 5331.09371406854, 5380.596455265871, 5415.864603384947, 5426.240326354314, 4982.078315511642, 4984.352034235599, 4987.351644286219, 4990.201567749143, 5030.7233102179, 5972.492338151219, 5977.820665380045, 5977.910331345033, 5978.432048955342, 5979.402059793986, 5565.0817615093865, 5730.140478928194, 5786.450287222707, 5828.358880523224, 5833.358330583717, 5922.022866227197, 5926.348101708722, 5927.407259274038, 5936.554758393051, 5941.1385349125, 5448.4006759257245, 5652.123920792284, 5656.066748986371, 5659.066254068032, 5662.7734890603915, 5724.4275572444085, 5786.450287222707, 5790.160426738184, 5823.388544202967, 5849.824505264849, 5598.076317407582, 5634.859128521656, 5635.9436405635415, 5646.745896434588, 5650.63270887391, 5386.542143917811, 5535.0, 5588.133839254922, 5598.3282006159525, 5632.239647647515, 5528.9723551381985, 5530.806421775219, 5536.2249285100925, 5547.944520554743, 5579.218909352775, 5619.971900140473, 5636.351819540805, 5662.546996240373, 5662.971685141548, 5666.206731057738, 5328.094223981855, 5507.752151153128, 5522.116461366162, 5543.36251331086, 5614.101743720985], "unit": "score", "name": "dojo.html", "value": 5295.318944804721}, {"lowerIsBetter": false, "replicates": [555.1869487159474, 577.3216470646988, 579.0561384942544, 595.4878804228366, 600.7476859718917, 39943.40084898725, 40549.79725101378, 40594.0, 40622.18755624886, 40622.79688601553, 42063.36904946428, 42102.57897421025, 42414.7879260604, 42482.575174248246, 42539.14921701564, 8801.383903126767, 8957.19385255327, 8978.281737460988, 8986.775330616721, 8988.910110898873, 8804.603792829306, 8909.287257019456, 8925.95537022314, 8926.419782714103, 8928.955355223216, 9206.723798286028, 9290.442573445582, 9296.070392960684, 9296.256299496057, 9300.20948219402, 9120.452772833618, 9186.632534698603, 9203.401778884385, 9205.079492050809, 9205.447673139566, 8938.329625278131, 9037.502937338444, 9059.456432614064, 9063.59213835379, 9065.864012039825, 43563.346549801776, 43658.563414365766, 44021.33967990483, 44025.55974440247, 44048.339274910584, 3440.3119376124873, 3515.8417871195857, 3535.027867336503, 3536.8938931832085, 3558.804265765382, 33071.173220669436, 33127.0, 33457.16357091068, 33626.49560256598, 34053.659463405296, 4270.466191726035, 4277.807498662536, 4334.631556317717, 4379.824807007716, 4423.336499525065, 330505.0, 334284.328578358, 335106.0, 337051.0, 337612.0, 60643.0, 61252.0, 61846.0, 61893.381066189664, 61900.69049654723, 69729.0, 70366.64816675884, 70622.2937770626, 70671.0, 70695.2930470699, 16178.75731864023, 16395.098269595048, 16408.097554634373, 16408.507744767678, 16409.507714768577, 12253.0, 12406.875931240753, 12440.440180191914, 12441.93779031099, 12444.626661200178, 21227.89386053091, 21229.893850530647, 21453.89273053625, 21480.140794368363, 22340.664890026663, 8321.500709957421, 8464.280536154372, 8475.364347673949, 8479.236868681848, 8593.871091933626, 1056.3081181825917, 1090.7382228265317, 1125.189863298424, 1131.9943400282946, 1133.195431243826, 32536.186595335304, 33121.83439082837, 33268.66731332656, 33341.16647083794, 33709.32581348409, 1162.2968104296947, 1174.988250117505, 1187.2935603316014, 1192.4574318684977, 1264.8355713757337, 16609.6678066438, 17287.222075006655, 17390.0, 18294.90852545729, 18372.724409133873, 227722.0, 228705.0, 229392.0, 229749.0, 230928.0, 60335.396646033856, 61942.0, 61957.38042619516, 61958.69020654868, 61983.0, 1244.2534479312521, 1325.5360623781407, 1327.0312671749678, 1422.1893520693106, 1453.6626303800529, 30884.0, 33471.49792753062, 33793.0, 34683.653163469055, 34887.825560872036, 54999.0, 55874.72062639661, 56132.15801763059, 56234.0, 56261.718691406284, 369106.0, 369691.0, 369843.0, 369860.0, 370685.0, 31130.688693113683, 36766.816165919, 37009.25981480409, 37125.257494849415, 37424.0, 41614.1677166461, 42238.788806055774, 46464.0, 47165.52834471611, 47644.7617761909, 39272.607273928035, 39471.21057578775, 39606.603933960294, 39648.0, 39730.80134599309, 38304.2339153221, 39084.413733793444, 39382.21235575215, 39457.2108557833, 40208.97387826522, 39990.80004599958, 40677.38983915303, 40931.795341023106, 41243.587564123976, 41321.380179296735, 32757.508637370935, 35190.12024699403, 35372.469412958315, 35416.64583354237, 35645.0, 27283.090183686953, 27713.0, 27859.72140278571, 27864.0, 27961.0], "unit": "score", "name": "ext.html", "value": 20048.731150286196}, {"lowerIsBetter": false, "replicates": [355.9697425718814, 358.4640961762165, 364.4897143998402, 368.2120262637955, 370.8331250937079, 17605.119744012794, 18116.90941545292, 19703.605927881435, 19721.90139049306, 19726.0, 18146.727799083023, 18222.180001899913, 19026.52433689155, 19057.237710491598, 19057.80942190578, 5570.080936645459, 5664.348599911022, 5676.886462270752, 5712.77148914045, 5731.770729170849, 4087.264292427362, 5641.68970706611, 5937.643741375509, 6159.10692949522, 6188.876222475547, 6237.126802247689, 6261.686915654199, 6264.906026409585, 6270.122182894398, 6285.434310912017, 6022.488088512482, 6149.631022138686, 6150.907736383958, 6156.6921653917125, 6239.532035097386, 3645.6901163401144, 5225.817096401608, 5432.565394768449, 5434.076207044812, 5477.643953143033, 20996.5800683987, 21095.261665841623, 21212.0, 23000.884995574914, 23025.309240722807, 2383.6305372667266, 2554.3997160667227, 2576.6779152605923, 2803.5374163263036, 2877.338212211182, 13854.376553055137, 13978.440862365493, 14154.0, 14353.210573418457, 14682.265886705622, 1962.0876292523901, 2011.989940050305, 2032.1566549881782, 2045.3530491738172, 2056.5886822635384, 71798.0, 72971.27028729698, 72977.63511182464, 73338.0, 73549.0, 9959.502024898726, 10078.14335781452, 10099.646512372032, 10174.440405777605, 10219.23355748307, 12522.248665080124, 12786.424610892533, 12791.0, 12797.616071517868, 12809.61571152867, 7566.962165189138, 7572.432067594952, 7689.505646123066, 7743.45795794289, 7801.141874393812, 7311.3785328247695, 7437.1447283562, 7495.700171993169, 7516.47384683067, 7532.322091011835, 6347.746090156435, 6451.645159516272, 6457.967710161419, 6458.2895881453005, 6519.217693876765, 1641.351666091887, 1732.462936489667, 1742.7995780485153, 1743.9128043597768, 1766.823317668223, 1035.6634093919506, 1048.5753269925692, 1052.6684094510206, 1073.22381458686, 1073.4847273308856, 17641.0, 18193.818061819213, 18250.0, 18378.448646540626, 19183.232670693294, 1022.1414012229762, 1030.2633616963906, 1033.7260625934134, 1072.7747173093737, 1105.3588918427292, 10446.268761186797, 10746.516406761715, 10911.399873006902, 11077.889221107847, 11167.162462815322, 494631.0, 504069.0, 506556.0, 506655.0, 509052.0, 91905.54047229855, 92085.0, 92268.0, 92582.53708731414, 94019.52990235006, 1081.329575663094, 1091.6561283195767, 1102.2174256278133, 1106.976047156377, 1110.2394859521253, 16708.16459177012, 16710.832891671413, 16767.832321676626, 16835.326586936386, 17129.914350428167, 39714.0, 39805.60194398019, 40320.596794032856, 40863.0, 41384.58615413928, 55452.16821747758, 55516.0, 55533.72233138808, 55743.72128139334, 55774.44225557693, 8354.832903342021, 8397.202265784741, 8438.0, 8461.40770146084, 8533.957330213558, 11581.768364632828, 12935.482580696667, 13086.803697944348, 13168.80246796318, 13274.469021239041, 11207.0, 11317.264377815416, 11532.308061516336, 11541.82687259675, 11566.190366674253, 11182.329060256085, 11354.602588909349, 11390.658280251606, 11492.827607585725, 11749.353785541878, 11314.377709226072, 11379.601713939972, 11914.459776204107, 11916.046716262505, 12037.0, 8316.459430137022, 8403.327733781161, 8453.873191902003, 8474.449160804528, 8515.19105684959, 10616.575336986434, 11706.76586468283, 11776.11679124052, 11887.227330223508, 11924.76150477003], "unit": "score", "name": "jquery.html", "value": 9226.35767656456}, {"lowerIsBetter": false, "replicates": [1329.980050299245, 1554.4015554011705, 1558.0, 1796.7394727764474, 1923.384516954574, 8115.107338192802, 8275.337972962163, 8361.707340243092, 8362.540060296682, 8368.58157092146, 8187.304079153264, 8358.91641083589, 8360.623771930263, 8385.538795366252, 8390.958045209765, 2066.4214020074405, 2316.050419328076, 2342.039763696876, 2359.0210062823908, 2406.4585468269674, 2368.4078980254935, 2372.0748907925836, 2372.8694921779297, 2375.1449478187837, 2375.4536456614987, 2229.3646310801423, 2318.6058370077126, 2320.5126923346033, 2324.1981516376823, 2327.592671282527, 2322.6516022596575, 2327.9418014549688, 2328.860268383902, 2337.392278007722, 2411.8311718179734, 2359.1153317505937, 2387.904483820645, 2391.497785465054, 2392.7966122879575, 2392.964105538418, 8159.184081591853, 8244.8351032979, 8249.876251856227, 8253.752387428387, 8254.339652827759, 5143.974280128613, 5293.86765330866, 5299.894002119974, 5300.681959082429, 5305.73471326436, 3315.287213249163, 3345.063382252973, 3386.407378708741, 3509.982450087759, 3518.753687241894, 1047.7799662070975, 1050.5482642463737, 1066.4081434803682, 1068.8824229334766, 1087.0434018064052, 11821.645350639494, 11828.52685892572, 11831.645050648494, 11872.940635296769, 11885.286882786973, 4667.13657973276, 4675.555822196886, 4727.64542659302, 4740.976295118571, 4765.833195838129, 9543.522823858779, 9597.472139032281, 9605.13553780163, 9610.375325603813, 9614.855777163348, 4637.86086417408, 5299.788008479618, 5332.173513105475, 5341.759620817073, 5348.518633322942, 4782.258749893772, 4792.2332426811545, 4856.2958371036, 4870.05034018363, 4877.097736918681, 3904.570497245301, 3942.3100957332354, 3958.0, 4007.8196481158416, 4036.6367026967714, 1196.5512932650256, 1201.225209739713, 1206.2280140709952, 1213.4842691855927, 1241.3234787041085, 1187.1808452167977, 1190.892819646236, 1209.661294837447, 1427.643089227693, 1444.5377479206552, 7828.452008359474, 7912.881306780403, 8014.358851291882, 8016.0, 8017.919820801834, 484.1720657675414, 493.948135445773, 499.094144128413, 503.7531609511313, 504.9368828896388, 5880.206172166702, 5912.260967379078, 5932.406759324033, 5957.017092179742, 5969.671668058299, 9939.304248702521, 10548.578056877639, 10578.312409693346, 10693.679189624168, 10698.572057117628, 10273.0, 10535.683929482127, 10570.2600817942, 10572.52423640938, 10611.681649550526, 8102.432829701865, 8174.3460523158, 8207.056188538276, 8255.380846436541, 8266.090730019692, 7847.529148251123, 7874.094479134744, 7906.7627971160955, 7919.485233459806, 7986.600669966595, 8938.50838203905, 9271.953640231755, 9501.239900807781, 9703.514824258618, 9745.463999480096, 9255.120763527455, 9397.389169703947, 9426.95286523563, 9462.479563624067, 9592.08875156859, 6449.677516124269, 7365.8526829462035, 7478.588677622783, 7610.847783044419, 7716.691332346868, 8035.276825085771, 8036.236557527026, 8043.477173983672, 8071.677132914852, 8086.676532938616, 7152.642367881481, 7157.821054473679, 7308.0, 7409.962950185431, 7446.069241344832, 7243.384312333511, 7255.2019277878335, 7259.52813067149, 7264.854702905806, 7354.485186036926, 7432.814179645336, 7454.105507338937, 7505.099388073466, 7510.586917719578, 7516.285952834472, 6969.0, 6995.230524642184, 6997.300269972962, 6997.895031574429, 7004.684789184601, 6709.194896612243, 6808.897866532105, 6824.522283440111, 6835.829104272433, 6840.247572767091], "unit": "score", "name": "mootools.html", "value": 4714.042587203643}, {"lowerIsBetter": false, "replicates": [342.09686427830525, 343.8951119908427, 344.51939544335636, 344.8879114287857, 352.69844283137917, 5987.4910632596175, 6035.3964603539625, 6070.69646517674, 6088.117223002668, 6090.269167699877, 6003.789867354643, 6017.789377371793, 6033.155358249848, 6050.8184754457325, 6052.092186172076, 4441.977790111045, 4556.635469162476, 4638.397008388904, 4655.953440465594, 4687.320338550908, 4664.323673067403, 4664.720116793003, 4675.789589468465, 4676.55572720591, 4680.087382960324, 4608.5161058088925, 4615.307703844416, 4616.492185859553, 4625.8149674013, 4640.419947506562, 4420.77896105195, 4513.661475389343, 4619.006913513611, 4634.976825115887, 4635.860924172281, 4044.8179831907637, 4063.6952228582973, 4065.24792913309, 4069.04377471294, 4073.450084238649, 5788.8842223155725, 5790.160426738099, 5791.82624521265, 5798.449147330997, 5813.273340832396, 5346.812861549827, 5354.143337066051, 5361.0, 5361.276227709287, 5365.865853353658, 6231.657258850807, 6292.905606415908, 6295.716692748837, 6297.527685423612, 6305.464035556983, 4393.780310984438, 4491.888812258266, 4494.775261236958, 4499.280115181556, 4502.234620114588, 6608.504362172808, 6617.37134972172, 6617.371349721769, 6625.966870165618, 6645.3354664533645, 4606.56237657422, 4608.055348653518, 4608.7556359782675, 4611.123886461562, 4611.216093264153, 4647.279671650899, 4648.372469716613, 4649.976750116295, 4652.790624421909, 4656.278276867091, 5286.682799032071, 5323.973380133075, 5328.706921119376, 5331.466853314638, 5336.439673834191, 6223.222097237845, 6345.904811427832, 6382.32985536512, 6401.327860574573, 6440.291567927524, 1578.1399137470107, 1584.7939767830107, 1592.9920350398174, 1593.6732969741174, 1599.4561848971405, 999.6501224571342, 1047.5233768635253, 1053.510117795229, 1074.215822449616, 1089.1395797320188, 5962.4633782959745, 5978.1929439525975, 5979.402059794073, 5981.850453738692, 5984.0, 6524.347565243533, 6561.40947314744, 6563.606183628997, 6567.244766851778, 6567.770128045496, 6026.005709057957, 6027.186329845415, 6032.668203248776, 6033.336333003366, 6040.6979651018155, 3459.100633835221, 3494.3884820156372, 3497.877574284939, 3498.8075655838666, 3499.61504234534, 6610.636414997221, 6698.933010669928, 6773.966130169416, 6782.084418603524, 6853.17761868579, 6750.291219421988, 6756.2568117507035, 6762.69567869447, 6763.154605674291, 6764.5603035802515, 6834.931650683529, 6836.38472537474, 6842.110525631636, 6845.007473916255, 6849.315068493111, 6610.3720146586, 6615.900761488678, 6619.669016549057, 6620.5034622402545, 6631.734730610721, 6388.39310265524, 6565.737370505126, 6572.539922205399, 6580.243272023587, 6590.077389165424, 6829.556078854858, 6853.00631408433, 6858.965705171442, 6862.451003919575, 6868.759593414206, 4475.9328610071525, 4498.865034048984, 4504.121696269196, 4508.977455112704, 4511.5262897395305, 6576.2766095728475, 6577.408033277028, 6594.901076483952, 6598.472122230114, 6615.6030638161865, 6160.322364539987, 6388.361163883575, 6419.64691941929, 6425.742970281136, 6457.225132984072, 6361.332060133805, 6402.87194256103, 6410.358964103552, 6420.6468644225015, 6425.389587989133, 6310.873782524415, 6317.147185129948, 6324.936750632435, 6326.810195694136, 6326.841828954313, 6446.67766611677, 6461.289258181502, 6461.838454038687, 6461.967690161519, 6472.15861937945, 5994.31065427464, 6095.96368617345, 6227.4395304421005, 6289.559730818982, 6292.244930608356], "unit": "score", "name": "prototype.html", "value": 4817.551206426992}, {"lowerIsBetter": false, "replicates": [791.2206476620528, 830.269362960595, 871.821276638289, 876.3996662286335, 903.0608167505794, 15088.396464141435, 15265.465708700198, 15270.847291527096, 15280.54158375249, 15281.541553753377, 14246.715065698705, 14291.928540357283, 14304.71390572188, 14315.0, 14333.713325733479, 698.4377576051277, 850.3324889961382, 866.5840396609631, 869.2394155114275, 870.9129087091303, 841.7769291137853, 864.9091845356241, 867.1588559097665, 872.8210716803072, 872.9301655867515, 887.2901678657081, 917.7338571814166, 920.4293338130368, 921.3918813583036, 921.787988762585, 737.5169264131976, 902.634433054614, 914.1909410171979, 915.3226612306911, 916.1800188831025, 638.3680156644934, 651.6090345792487, 661.3518751623388, 667.6428110960612, 668.812732434919, 13705.862941370558, 13709.245991470465, 13746.0, 13763.0, 13766.862331376758, 14145.646358841008, 14430.927845360811, 14506.41974321026, 14671.33978970949, 14680.779788303184, 11296.887031129665, 11465.656030319104, 11593.826092608617, 11680.824787628193, 11756.529738810437, 3850.7304488685804, 3872.7289089763726, 3936.566977632458, 3950.249452603996, 3973.443717879499, 55077.72461137669, 55141.0, 55231.0, 55414.44585554133, 55521.72239138778, 10600.893991059991, 10891.945540272249, 11006.559737610405, 11315.321080735182, 11322.830157547643, 19921.402357929284, 19991.60016799656, 20006.89996550037, 20042.298519552038, 20096.49758756043, 8674.0, 8674.175953284428, 8699.695510657097, 8758.2993360531, 8805.207531322212, 4833.975830120827, 4891.55975962158, 4983.277424773388, 5039.4708555601865, 5069.44236134025, 3524.1013541547254, 3561.5013898054294, 3575.8390872410805, 3584.7849129052343, 3600.2979419013564, 585.6017907822721, 650.3334082565314, 671.1744554198364, 684.5345165287653, 689.8896176611718, 683.7641013850214, 779.8323360477525, 784.2667106255669, 796.2197046894076, 800.2917418085036, 9255.213306868856, 9877.950610246902, 10015.849762253572, 10027.548760305805, 10036.447995360326, 695.09984569982, 743.8437928035065, 762.6644276518314, 797.0992778160758, 828.6726742936506, 4506.143832671782, 4510.819567217274, 4583.564561366665, 4624.953750462452, 4657.3246879202325, 67153.0, 67160.32839671639, 67473.0, 67556.0, 67718.66140669363, 56268.718656407276, 58981.705091474265, 59106.70446647739, 59515.0, 59551.404485955456, 51261.0, 51502.48497515052, 52005.219921700445, 52564.47435525596, 52618.736906315986, 9282.0, 9302.581383837878, 9307.72076837696, 9392.154706076486, 9404.764880878032, 37911.62088379081, 38146.046348841504, 38648.42027369535, 38744.418833716954, 38857.41713874238, 44787.104257914005, 48254.75872620614, 50924.0, 51001.0, 52157.0, 11542.538298467967, 11576.942115289707, 11839.520059992501, 12436.129470936947, 12889.871101288867, 13606.863931360956, 14378.496752613608, 14464.13215207091, 14725.55823325302, 15380.230988450756, 13633.182009079486, 13748.725025499634, 13805.79291310611, 14148.575542733735, 14251.073680211168, 13398.464061437433, 13767.655808604464, 13801.86198138046, 13822.861771382157, 14310.0, 13699.589012329647, 13764.105333153313, 13791.724165516835, 13859.029867909552, 13960.0, 9937.850932236166, 9968.352057116264, 9977.151942085004, 10100.797984040424, 10760.946195268974, 10732.517036733521, 10874.565017399216, 10967.945160274467, 10992.0, 11001.339919604849], "unit": "score", "name": "yui.html", "value": 7077.860372954009}], "name": "dromaeo_css", "value": 7348.439975787522}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 108.0, 104.0, 108.0, 110.0, 109.0, 98.0, 108.0, 108.0, 111.0], "unit": "score", "name": "ai-astar", "value": 107.3}, {"lowerIsBetter": true, "replicates": [153.0, 125.0, 148.0, 180.0, 126.0, 149.0, 153.0, 123.0, 169.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 145.0}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 161.0, 162.0, 159.0, 161.0, 161.0, 163.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.1}, {"lowerIsBetter": true, "replicates": [72.0, 75.0, 91.0, 97.0, 75.0, 75.0, 74.0, 105.0, 91.0, 75.0], "unit": "score", "name": "audio-fft", "value": 83.0}, {"lowerIsBetter": true, "replicates": [93.0, 92.0, 150.0, 92.0, 93.0, 93.0, 146.0, 91.0, 92.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 108.4}, {"lowerIsBetter": true, "replicates": [116.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.2}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 146.0, 146.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [57.0, 55.0, 55.0, 55.0, 55.0, 55.0, 56.0, 59.0, 57.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 56.1}, {"lowerIsBetter": true, "replicates": [61.0, 61.0, 60.0, 60.0, 61.0, 61.0, 61.0, 59.0, 60.0, 61.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 60.5}, {"lowerIsBetter": true, "replicates": [77.0, 78.0, 76.0, 77.0, 78.0, 78.0, 77.0, 78.0, 88.0, 80.0], "unit": "score", "name": "stanford-crypto-aes", "value": 78.7}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 108.0, 107.0, 114.0, 109.0, 115.0, 121.0, 108.0, 110.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 111.2}, {"lowerIsBetter": true, "replicates": [138.0, 138.0, 138.0, 136.0, 140.0, 141.0, 137.0, 139.0, 139.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 138.3}, {"lowerIsBetter": true, "replicates": [64.0, 62.0, 64.0, 63.0, 62.0, 63.0, 63.0, 61.0, 62.0, 61.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 62.5}], "name": "kraken", "value": 1470.3}]} 08:30:01 INFO - Return code: 0 08:30:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 08:30:01 ERROR - # TBPL SUCCESS # 08:30:01 INFO - Running post-action listener: _resource_record_post_action 08:30:01 INFO - Running post-run listener: _resource_record_post_run 08:30:02 INFO - Total resource usage - Wall time: 1301s; CPU: 13.0%; Read bytes: 20480; Write bytes: 538447872; Read time: 1208; Write time: 10158028 08:30:02 INFO - install - Wall time: 23s; CPU: 26.0%; Read bytes: 0; Write bytes: 158396416; Read time: 0; Write time: 1482772 08:30:02 INFO - run-tests - Wall time: 1279s; CPU: 13.0%; Read bytes: 20480; Write bytes: 380051456; Read time: 1208; Write time: 8675256 08:30:02 INFO - Running post-run listener: _upload_blobber_files 08:30:02 INFO - Blob upload gear active. 08:30:02 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 08:30:02 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 08:30:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 08:30:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 08:30:03 INFO - (blobuploader) - INFO - Open directory for files ... 08:30:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 08:30:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:30:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:30:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:30:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:30:04 INFO - (blobuploader) - INFO - Done attempting. 08:30:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:30:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:30:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:30:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:30:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:30:04 INFO - (blobuploader) - INFO - Done attempting. 08:30:04 INFO - (blobuploader) - INFO - Iteration through files over. 08:30:04 INFO - Return code: 0 08:30:04 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 08:30:04 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 08:30:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/888f3b156d666a6b3db625edca4261ddff6943efd82afb7fe4cf49b2b80bf05ceede7e028e812a1ebe156b76dcd31947c8b3316f5d862c151fbf94e07c810835", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/60a3a973abc75b2f9866e93cf5118f2690187df50e1f5ded8ee6058c8899f127d00ea212b21ef3fccdbdc5fdeb4727f8bb759e7e4d12bc3c50b43c08f3094222"} 08:30:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 08:30:04 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 08:30:04 INFO - Contents: 08:30:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/888f3b156d666a6b3db625edca4261ddff6943efd82afb7fe4cf49b2b80bf05ceede7e028e812a1ebe156b76dcd31947c8b3316f5d862c151fbf94e07c810835", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/60a3a973abc75b2f9866e93cf5118f2690187df50e1f5ded8ee6058c8899f127d00ea212b21ef3fccdbdc5fdeb4727f8bb759e7e4d12bc3c50b43c08f3094222"} 08:30:04 INFO - Running post-run listener: copy_logs_to_upload_dir 08:30:04 INFO - Copying logs to upload dir... 08:30:04 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 08:30:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1353.820064 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 33 secs) (at 2016-03-15 08:30:04.943941) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-15 08:30:04.947109) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=edae0fb5fee9fb758e8af6d3000002a4-1458054131.57783-1983725906 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/888f3b156d666a6b3db625edca4261ddff6943efd82afb7fe4cf49b2b80bf05ceede7e028e812a1ebe156b76dcd31947c8b3316f5d862c151fbf94e07c810835", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/60a3a973abc75b2f9866e93cf5118f2690187df50e1f5ded8ee6058c8899f127d00ea212b21ef3fccdbdc5fdeb4727f8bb759e7e4d12bc3c50b43c08f3094222"} build_url:https://queue.taskcluster.net/v1/task/Dct_jsB9QN6P-jwKyj07fg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010313 build_url: 'https://queue.taskcluster.net/v1/task/Dct_jsB9QN6P-jwKyj07fg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/888f3b156d666a6b3db625edca4261ddff6943efd82afb7fe4cf49b2b80bf05ceede7e028e812a1ebe156b76dcd31947c8b3316f5d862c151fbf94e07c810835", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/60a3a973abc75b2f9866e93cf5118f2690187df50e1f5ded8ee6058c8899f127d00ea212b21ef3fccdbdc5fdeb4727f8bb759e7e4d12bc3c50b43c08f3094222"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-15 08:30:04.970566) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 08:30:04.970910) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=edae0fb5fee9fb758e8af6d3000002a4-1458054131.57783-1983725906 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004224 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 08:30:05.054993) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-15 08:30:05.055370) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-15 08:30:05.055709) ========= ========= Total master_lag: 0.61 =========