builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-030 starttime: 1458796283.97 results: success (0) buildid: 20160323193423 builduid: 13a597205674473b92753d580d42a209 revision: c7192c4eecd0657907c4a40ac88db34298b6cc10 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-23 22:11:23.969889) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-23 22:11:23.970373) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-23 22:11:23.970683) ========= 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=4ac8d263c7293b36a1be1aed000001be-1458787044.235786-1166472986 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006441 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-23 22:11:23.993677) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-23 22:11:23.993982) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-23 22:11:24.007392) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 22:11:24.007861) ========= 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=4ac8d263c7293b36a1be1aed000001be-1458787044.235786-1166472986 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004601 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 22:11:24.058061) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-23 22:11:24.058392) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-23 22:11:24.059078) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 22:11:24.059368) ========= 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=4ac8d263c7293b36a1be1aed000001be-1458787044.235786-1166472986 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-23 22:11:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 53.7K=0.2s 2016-03-23 22:11:24 (53.7 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.458687 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 22:11:24.573247) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 22:11:24.573555) ========= 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=4ac8d263c7293b36a1be1aed000001be-1458787044.235786-1166472986 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018910 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 22:11:24.609804) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 22:11:24.610119) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev c7192c4eecd0657907c4a40ac88db34298b6cc10 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev c7192c4eecd0657907c4a40ac88db34298b6cc10 --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=4ac8d263c7293b36a1be1aed000001be-1458787044.235786-1166472986 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-23 22:11:24,775 truncating revision to first 12 chars 2016-03-23 22:11:24,775 Setting DEBUG logging. 2016-03-23 22:11:24,775 attempt 1/10 2016-03-23 22:11:24,775 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/c7192c4eecd0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-23 22:11:25,026 unpacking tar archive at: mozilla-inbound-c7192c4eecd0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.505388 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 22:11:25.128274) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-23 22:11:25.128574) ========= echo c7192c4eecd0657907c4a40ac88db34298b6cc10 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'c7192c4eecd0657907c4a40ac88db34298b6cc10'] 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=4ac8d263c7293b36a1be1aed000001be-1458787044.235786-1166472986 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False c7192c4eecd0657907c4a40ac88db34298b6cc10 program finished with exit code 0 elapsedTime=0.003419 script_repo_revision: 'c7192c4eecd0657907c4a40ac88db34298b6cc10' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-23 22:11:25.175511) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-23 22:11:25.175821) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-23 22:11:25.185808) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-03-23 22:11:25.186123) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4ac8d263c7293b36a1be1aed000001be-1458787044.235786-1166472986 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:11:25 INFO - MultiFileLogger online at 20160323 22:11:25 in /builds/slave/test-pgo 22:11:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 22:11:25 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:11:25 INFO - {'append_to_log': False, 22:11:25 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:11:25 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 22:11:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:11:25 INFO - 'branch': 'Mozilla-Inbound', 22:11:25 INFO - 'buildbot_json_path': 'buildprops.json', 22:11:25 INFO - 'config_files': ('talos/linux_config.py',), 22:11:25 INFO - 'default_actions': ('clobber', 22:11:25 INFO - 'read-buildbot-config', 22:11:25 INFO - 'download-and-extract', 22:11:25 INFO - 'populate-webroot', 22:11:25 INFO - 'create-virtualenv', 22:11:25 INFO - 'install', 22:11:25 INFO - 'run-tests'), 22:11:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:11:25 INFO - 'download_minidump_stackwalk': True, 22:11:25 INFO - 'download_symbols': 'ondemand', 22:11:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:11:25 INFO - 'tooltool.py': '/tools/tooltool.py', 22:11:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:11:25 INFO - '/tools/misc-python/virtualenv.py')}, 22:11:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:11:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:11:25 INFO - 'installer_path': 'installer.exe', 22:11:25 INFO - 'log_level': 'info', 22:11:25 INFO - 'log_name': 'talos', 22:11:25 INFO - 'log_to_console': True, 22:11:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:11:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:11:25 INFO - 'opt_config_files': (), 22:11:25 INFO - 'pip_index': False, 22:11:25 INFO - 'sps_profile': False, 22:11:25 INFO - 'sps_profile_interval': 0, 22:11:25 INFO - 'suite': 'dromaeojs', 22:11:25 INFO - 'system_bits': '32', 22:11:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:11:25 INFO - 'title': 'talos-linux64-ix-030', 22:11:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:11:25 INFO - 'use_talos_json': True, 22:11:25 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:11:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:11:25 INFO - 'work_dir': 'build'} 22:11:25 INFO - ##### 22:11:25 INFO - ##### Running clobber step. 22:11:25 INFO - ##### 22:11:25 INFO - Running pre-action listener: _resource_record_pre_action 22:11:25 INFO - Running main action method: clobber 22:11:25 INFO - rmtree: /builds/slave/test-pgo/build 22:11:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:11:25 INFO - Running post-action listener: _resource_record_post_action 22:11:25 INFO - ##### 22:11:25 INFO - ##### Running read-buildbot-config step. 22:11:25 INFO - ##### 22:11:25 INFO - Running pre-action listener: _resource_record_pre_action 22:11:25 INFO - Running main action method: read_buildbot_config 22:11:25 INFO - Using buildbot properties: 22:11:25 INFO - { 22:11:25 INFO - "project": "", 22:11:25 INFO - "product": "firefox", 22:11:25 INFO - "script_repo_revision": "production", 22:11:25 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 22:11:25 INFO - "repository": "", 22:11:25 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 22:11:25 INFO - "buildid": "20160323193423", 22:11:25 INFO - "pgo_build": "True", 22:11:25 INFO - "basedir": "/builds/slave/test-pgo", 22:11:25 INFO - "buildnumber": 824, 22:11:25 INFO - "slavename": "talos-linux64-ix-030", 22:11:25 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:11:25 INFO - "platform": "ubuntu64_hw", 22:11:25 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 22:11:25 INFO - "branch": "mozilla-inbound", 22:11:25 INFO - "repo_path": "integration/mozilla-inbound", 22:11:25 INFO - "revision": "c7192c4eecd0657907c4a40ac88db34298b6cc10", 22:11:25 INFO - "stage_platform": "linux64-pgo", 22:11:25 INFO - "builduid": "13a597205674473b92753d580d42a209", 22:11:25 INFO - "slavebuilddir": "test" 22:11:25 INFO - } 22:11:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/DC7IPQZhRDeCkRNshbNrbA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 22:11:25 INFO - Running post-action listener: _resource_record_post_action 22:11:25 INFO - ##### 22:11:25 INFO - ##### Running download-and-extract step. 22:11:25 INFO - ##### 22:11:25 INFO - Running pre-action listener: _resource_record_pre_action 22:11:25 INFO - Running main action method: download_and_extract 22:11:25 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:11:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:11:25 INFO - https://queue.taskcluster.net/v1/task/DC7IPQZhRDeCkRNshbNrbA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:11:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DC7IPQZhRDeCkRNshbNrbA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:11:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DC7IPQZhRDeCkRNshbNrbA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:11:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DC7IPQZhRDeCkRNshbNrbA/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 22:11:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DC7IPQZhRDeCkRNshbNrbA/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 22:11:38 INFO - Downloaded 1361 bytes. 22:11:38 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:11:38 INFO - Using the following test package requirements: 22:11:38 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:11:38 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:11:38 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:11:38 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:11:38 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:11:38 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:11:38 INFO - u'jsshell-linux-x86_64.zip'], 22:11:38 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:11:38 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:11:38 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:11:38 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:11:38 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:11:38 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:11:38 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:11:38 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:11:38 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:11:38 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:11:38 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:11:38 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:11:38 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')]} 22:11:38 INFO - https://queue.taskcluster.net/v1/task/DC7IPQZhRDeCkRNshbNrbA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:11:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DC7IPQZhRDeCkRNshbNrbA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:11:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DC7IPQZhRDeCkRNshbNrbA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:11:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DC7IPQZhRDeCkRNshbNrbA/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 22:11:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DC7IPQZhRDeCkRNshbNrbA/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 22:11:40 INFO - Downloaded 23636493 bytes. 22:11:40 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'] 22:11:40 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 22:11:41 INFO - Return code: 0 22:11:41 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 22:11:41 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')]} 22:11:41 INFO - https://queue.taskcluster.net/v1/task/DC7IPQZhRDeCkRNshbNrbA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:11:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DC7IPQZhRDeCkRNshbNrbA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:11:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DC7IPQZhRDeCkRNshbNrbA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:11:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DC7IPQZhRDeCkRNshbNrbA/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 22:11:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DC7IPQZhRDeCkRNshbNrbA/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 22:11:45 INFO - Downloaded 23636493 bytes. 22:11:45 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'] 22:11:45 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 22:11:47 INFO - Return code: 0 22:11:47 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')]} 22:11:47 INFO - https://queue.taskcluster.net/v1/task/DC7IPQZhRDeCkRNshbNrbA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:11:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DC7IPQZhRDeCkRNshbNrbA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:11:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DC7IPQZhRDeCkRNshbNrbA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:11:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DC7IPQZhRDeCkRNshbNrbA/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 22:11:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DC7IPQZhRDeCkRNshbNrbA/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 22:11:48 INFO - Downloaded 10846780 bytes. 22:11:48 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'] 22:11:48 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 22:11:48 INFO - Return code: 0 22:11:48 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')]} 22:11:48 INFO - https://queue.taskcluster.net/v1/task/DC7IPQZhRDeCkRNshbNrbA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:11:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DC7IPQZhRDeCkRNshbNrbA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:11:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DC7IPQZhRDeCkRNshbNrbA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:11:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DC7IPQZhRDeCkRNshbNrbA/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 22:11:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DC7IPQZhRDeCkRNshbNrbA/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 22:11:50 INFO - Downloaded 57722853 bytes. 22:11:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DC7IPQZhRDeCkRNshbNrbA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:11:50 INFO - mkdir: /builds/slave/test-pgo/properties 22:11:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:11:50 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:11:50 INFO - Contents: 22:11:50 INFO - build_url:https://queue.taskcluster.net/v1/task/DC7IPQZhRDeCkRNshbNrbA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:11:51 INFO - Running post-action listener: _resource_record_post_action 22:11:51 INFO - Running post-action listener: set_extra_try_arguments 22:11:51 INFO - ##### 22:11:51 INFO - ##### Running populate-webroot step. 22:11:51 INFO - ##### 22:11:51 INFO - Running pre-action listener: _resource_record_pre_action 22:11:51 INFO - Running main action method: populate_webroot 22:11:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:11:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:11:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:11:51 INFO - '--tppagecycles', 22:11:51 INFO - '7'], 22:11:51 INFO - 'tests': ['tsvgm']}}, 22:11:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:11:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:11:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:11:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 22:11:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:11:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:11:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:11:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:11:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:11:51 INFO - 'talos_options': ['--e10s'], 22:11:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:11:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:11:51 INFO - 'tests': ['damp', 'tps']}, 22:11:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:11:51 INFO - 'talos_options': ['--e10s'], 22:11:51 INFO - 'tests': ['damp', 'tps']}, 22:11:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:11:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:11:51 INFO - 'other': {'tests': ['a11yr', 22:11:51 INFO - 'ts_paint', 22:11:51 INFO - 'tpaint', 22:11:51 INFO - 'sessionrestore', 22:11:51 INFO - 'sessionrestore_no_auto_restore', 22:11:51 INFO - 'tabpaint']}, 22:11:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:11:51 INFO - 'tests': ['a11yr', 22:11:51 INFO - 'ts_paint', 22:11:51 INFO - 'tpaint', 22:11:51 INFO - 'sessionrestore', 22:11:51 INFO - 'sessionrestore_no_auto_restore', 22:11:51 INFO - 'tabpaint']}, 22:11:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:11:51 INFO - 'tests': ['a11yr', 22:11:51 INFO - 'ts_paint', 22:11:51 INFO - 'tpaint', 22:11:51 INFO - 'sessionrestore', 22:11:51 INFO - 'sessionrestore_no_auto_restore', 22:11:51 INFO - 'tabpaint']}, 22:11:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:11:51 INFO - 'tests': ['a11yr', 22:11:51 INFO - 'ts_paint', 22:11:51 INFO - 'tpaint', 22:11:51 INFO - 'sessionrestore', 22:11:51 INFO - 'sessionrestore_no_auto_restore', 22:11:51 INFO - 'tabpaint']}, 22:11:51 INFO - 'other_l64': {'tests': ['a11yr', 22:11:51 INFO - 'ts_paint', 22:11:51 INFO - 'tpaint', 22:11:51 INFO - 'sessionrestore', 22:11:51 INFO - 'sessionrestore_no_auto_restore', 22:11:51 INFO - 'tabpaint']}, 22:11:51 INFO - 'other_nol64': {'tests': ['a11yr', 22:11:51 INFO - 'ts_paint', 22:11:51 INFO - 'tpaint', 22:11:51 INFO - 'sessionrestore', 22:11:51 INFO - 'sessionrestore_no_auto_restore', 22:11:51 INFO - 'tabpaint']}, 22:11:51 INFO - 'svgr': {'tests': ['tsvgx', 22:11:51 INFO - 'tsvgr_opacity', 22:11:51 INFO - 'tart', 22:11:51 INFO - 'tscrollx', 22:11:51 INFO - 'cart']}, 22:11:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:11:51 INFO - 'tests': ['tsvgx', 22:11:51 INFO - 'tsvgr_opacity', 22:11:51 INFO - 'tart', 22:11:51 INFO - 'tscrollx', 22:11:51 INFO - 'cart']}, 22:11:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:11:51 INFO - 'tests': ['tp5o']}, 22:11:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:11:51 INFO - 'talos_options': ['--e10s'], 22:11:51 INFO - 'tests': ['tp5o']}, 22:11:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:11:51 INFO - 'talos_options': ['--xperf_path', 22:11:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:11:51 INFO - 'tests': ['tp5n']}, 22:11:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:11:51 INFO - 'talos_options': ['--e10s', 22:11:51 INFO - '--xperf_path', 22:11:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:11:51 INFO - 'tests': ['tp5n']}}, 22:11:51 INFO - 'talos.zip': {'path': '', 22:11:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:11:51 INFO - Running post-action listener: _resource_record_post_action 22:11:51 INFO - ##### 22:11:51 INFO - ##### Running create-virtualenv step. 22:11:51 INFO - ##### 22:11:51 INFO - Running pre-action listener: _resource_record_pre_action 22:11:51 INFO - Running main action method: create_virtualenv 22:11:51 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:11:51 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 22:11:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:11:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:11:51 INFO - Using real prefix '/usr' 22:11:51 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:11:52 INFO - Installing distribute.............................................................................................................................................................................................done. 22:11:54 INFO - Installing pip.................done. 22:11:54 INFO - Return code: 0 22:11:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:11:54 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')]} 22:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:11:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:54 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')]} 22:11:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:11:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:54 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 0x7f89f5df5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14238d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b28b0>, '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 0x14b37b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b3c60>, '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': '4ac8d263c7293b36a1be1aed000001be-1458787044.235786-1166472986', '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 22:11:54 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 22:11:54 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 22:11:54 INFO - Using env: {'DISPLAY': ':0', 22:11:54 INFO - 'HOME': '/home/cltbld', 22:11:54 INFO - 'LANG': 'en_US.UTF-8', 22:11:54 INFO - 'LANGUAGE': 'en_US:en', 22:11:54 INFO - 'LOGNAME': 'cltbld', 22:11:54 INFO - 'MAIL': '/var/mail/cltbld', 22:11:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:54 INFO - 'MOZ_NO_REMOTE': '1', 22:11:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:11:54 INFO - 'NO_EM_RESTART': '1', 22:11:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:11:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:11:54 INFO - 'PWD': '/builds/slave/test-pgo', 22:11:54 INFO - 'SHELL': '/bin/bash', 22:11:54 INFO - 'SHLVL': '1', 22:11:54 INFO - 'TERM': 'linux', 22:11:54 INFO - 'TMOUT': '86400', 22:11:54 INFO - 'USER': 'cltbld', 22:11:54 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1458787044.235786-1166472986', 22:11:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:54 INFO - '_': '/tools/buildbot/bin/python'} 22:11:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:11:54 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 22:11:54 INFO - Cleaning up... 22:11:54 INFO - Return code: 0 22:11:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:11:54 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')]} 22:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:11:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:54 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')]} 22:11:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:11:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:54 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 0x7f89f5df5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14238d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b28b0>, '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 0x14b37b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b3c60>, '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': '4ac8d263c7293b36a1be1aed000001be-1458787044.235786-1166472986', '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 22:11:54 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 22:11:54 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 22:11:54 INFO - Using env: {'DISPLAY': ':0', 22:11:54 INFO - 'HOME': '/home/cltbld', 22:11:54 INFO - 'LANG': 'en_US.UTF-8', 22:11:54 INFO - 'LANGUAGE': 'en_US:en', 22:11:54 INFO - 'LOGNAME': 'cltbld', 22:11:54 INFO - 'MAIL': '/var/mail/cltbld', 22:11:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:54 INFO - 'MOZ_NO_REMOTE': '1', 22:11:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:11:54 INFO - 'NO_EM_RESTART': '1', 22:11:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:11:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:11:54 INFO - 'PWD': '/builds/slave/test-pgo', 22:11:54 INFO - 'SHELL': '/bin/bash', 22:11:54 INFO - 'SHLVL': '1', 22:11:54 INFO - 'TERM': 'linux', 22:11:54 INFO - 'TMOUT': '86400', 22:11:54 INFO - 'USER': 'cltbld', 22:11:54 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1458787044.235786-1166472986', 22:11:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:54 INFO - '_': '/tools/buildbot/bin/python'} 22:11:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:11:54 INFO - Downloading/unpacking psutil>=0.7.1 22:11:54 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 22:11:54 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 22:11:54 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 22:11:54 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 22:11:54 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 22:11:54 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 22:11:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:11:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:11:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:11:56 INFO - Installing collected packages: psutil 22:11:56 INFO - Running setup.py install for psutil 22:11:56 INFO - building 'psutil._psutil_linux' extension 22:11:56 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 22:11:56 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 22:11:56 INFO - building 'psutil._psutil_posix' extension 22:11:56 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 22:11:57 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 22:11:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:11:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:11:57 INFO - Successfully installed psutil 22:11:57 INFO - Cleaning up... 22:11:57 INFO - Return code: 0 22:11:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:11:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:11:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:11:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:11:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:57 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 0x7f89f5df5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14238d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b28b0>, '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 0x14b37b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b3c60>, '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': '4ac8d263c7293b36a1be1aed000001be-1458787044.235786-1166472986', '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 22:11:57 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 22:11:57 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 22:11:57 INFO - Using env: {'DISPLAY': ':0', 22:11:57 INFO - 'HOME': '/home/cltbld', 22:11:57 INFO - 'LANG': 'en_US.UTF-8', 22:11:57 INFO - 'LANGUAGE': 'en_US:en', 22:11:57 INFO - 'LOGNAME': 'cltbld', 22:11:57 INFO - 'MAIL': '/var/mail/cltbld', 22:11:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:57 INFO - 'MOZ_NO_REMOTE': '1', 22:11:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:11:57 INFO - 'NO_EM_RESTART': '1', 22:11:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:11:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:11:57 INFO - 'PWD': '/builds/slave/test-pgo', 22:11:57 INFO - 'SHELL': '/bin/bash', 22:11:57 INFO - 'SHLVL': '1', 22:11:57 INFO - 'TERM': 'linux', 22:11:57 INFO - 'TMOUT': '86400', 22:11:57 INFO - 'USER': 'cltbld', 22:11:57 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1458787044.235786-1166472986', 22:11:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:57 INFO - '_': '/tools/buildbot/bin/python'} 22:11:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:11:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:11:57 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 22:11:57 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 22:11:57 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 22:11:57 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 22:11:57 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 22:11:57 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 22:11:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:11:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:11:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:11:59 INFO - Installing collected packages: mozsystemmonitor 22:11:59 INFO - Running setup.py install for mozsystemmonitor 22:11:59 INFO - Successfully installed mozsystemmonitor 22:11:59 INFO - Cleaning up... 22:11:59 INFO - Return code: 0 22:11:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:11:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:11:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:11:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:11:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:59 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 0x7f89f5df5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14238d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b28b0>, '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 0x14b37b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b3c60>, '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': '4ac8d263c7293b36a1be1aed000001be-1458787044.235786-1166472986', '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 22:11:59 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 22:11:59 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 22:11:59 INFO - Using env: {'DISPLAY': ':0', 22:11:59 INFO - 'HOME': '/home/cltbld', 22:11:59 INFO - 'LANG': 'en_US.UTF-8', 22:11:59 INFO - 'LANGUAGE': 'en_US:en', 22:11:59 INFO - 'LOGNAME': 'cltbld', 22:11:59 INFO - 'MAIL': '/var/mail/cltbld', 22:11:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:59 INFO - 'MOZ_NO_REMOTE': '1', 22:11:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:11:59 INFO - 'NO_EM_RESTART': '1', 22:11:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:11:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:11:59 INFO - 'PWD': '/builds/slave/test-pgo', 22:11:59 INFO - 'SHELL': '/bin/bash', 22:11:59 INFO - 'SHLVL': '1', 22:11:59 INFO - 'TERM': 'linux', 22:11:59 INFO - 'TMOUT': '86400', 22:11:59 INFO - 'USER': 'cltbld', 22:11:59 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1458787044.235786-1166472986', 22:11:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:59 INFO - '_': '/tools/buildbot/bin/python'} 22:11:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:11:59 INFO - Downloading/unpacking blobuploader==1.2.4 22:11:59 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 22:11:59 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 22:11:59 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 22:11:59 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 22:11:59 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 22:11:59 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 22:12:01 INFO - Downloading blobuploader-1.2.4.tar.gz 22:12:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:12:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:12: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 22:12: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 22:12: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 22:12: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 22:12: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 22:12: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 22:12:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:12:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:12: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 22:12: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 22:12: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 22:12: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 22:12: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 22:12: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 22:12:02 INFO - Downloading docopt-0.6.1.tar.gz 22:12:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:12:02 INFO - Installing collected packages: blobuploader, requests, docopt 22:12:02 INFO - Running setup.py install for blobuploader 22:12:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:12:02 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:12:02 INFO - Running setup.py install for requests 22:12:02 INFO - Running setup.py install for docopt 22:12:02 INFO - Successfully installed blobuploader requests docopt 22:12:02 INFO - Cleaning up... 22:12:02 INFO - Return code: 0 22:12:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:12:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:12:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:12:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:12:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:12:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:02 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 0x7f89f5df5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14238d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b28b0>, '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 0x14b37b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b3c60>, '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': '4ac8d263c7293b36a1be1aed000001be-1458787044.235786-1166472986', '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 22:12:02 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 22:12:02 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 22:12:02 INFO - Using env: {'DISPLAY': ':0', 22:12:02 INFO - 'HOME': '/home/cltbld', 22:12:02 INFO - 'LANG': 'en_US.UTF-8', 22:12:02 INFO - 'LANGUAGE': 'en_US:en', 22:12:02 INFO - 'LOGNAME': 'cltbld', 22:12:02 INFO - 'MAIL': '/var/mail/cltbld', 22:12:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:12:02 INFO - 'MOZ_NO_REMOTE': '1', 22:12:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:12:02 INFO - 'NO_EM_RESTART': '1', 22:12:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:12:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:12:02 INFO - 'PWD': '/builds/slave/test-pgo', 22:12:02 INFO - 'SHELL': '/bin/bash', 22:12:02 INFO - 'SHLVL': '1', 22:12:02 INFO - 'TERM': 'linux', 22:12:02 INFO - 'TMOUT': '86400', 22:12:02 INFO - 'USER': 'cltbld', 22:12:02 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1458787044.235786-1166472986', 22:12:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:12:02 INFO - '_': '/tools/buildbot/bin/python'} 22:12:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:12:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:12:03 INFO - Running setup.py (path:/tmp/pip-nRUofX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:12:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:12:03 INFO - Running setup.py (path:/tmp/pip-sc_5vK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:12:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:12:03 INFO - Running setup.py (path:/tmp/pip-0FAoht-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:12:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:12:03 INFO - Running setup.py (path:/tmp/pip-0fsurH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:12:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:12:03 INFO - Running setup.py (path:/tmp/pip-qr0Jtl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:12:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:12:03 INFO - Running setup.py (path:/tmp/pip-CfpVGd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:12:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:12:03 INFO - Running setup.py (path:/tmp/pip-jOVlPZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:12:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:12:03 INFO - Running setup.py (path:/tmp/pip-OnE2Rq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:12:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:12:03 INFO - Running setup.py (path:/tmp/pip-5FQBia-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:12:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:12:03 INFO - Running setup.py (path:/tmp/pip-U_TXHX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:12:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:12:03 INFO - Running setup.py (path:/tmp/pip-iBddH_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:12:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:12:03 INFO - Running setup.py (path:/tmp/pip-ASXKJq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:12:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:12:03 INFO - Running setup.py (path:/tmp/pip-MvRxp3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:12:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:12:04 INFO - Running setup.py (path:/tmp/pip-inJq_4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:12:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:12:04 INFO - Running setup.py (path:/tmp/pip-h1hYJs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:12:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:12:04 INFO - Running setup.py (path:/tmp/pip-7EtwRz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:12:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:12:04 INFO - Running setup.py (path:/tmp/pip-_NIauR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:12:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:12:04 INFO - Running setup.py install for manifestparser 22:12:04 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:12:04 INFO - Running setup.py install for mozcrash 22:12:04 INFO - Running setup.py install for mozdebug 22:12:04 INFO - Running setup.py install for mozdevice 22:12:04 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:12:04 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:12:04 INFO - Running setup.py install for mozfile 22:12:04 INFO - Running setup.py install for mozhttpd 22:12:04 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:12:04 INFO - Running setup.py install for mozinfo 22:12:05 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:12:05 INFO - Running setup.py install for mozInstall 22:12:05 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:12:05 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:12:05 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:12:05 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:12:05 INFO - Running setup.py install for mozleak 22:12:05 INFO - Running setup.py install for mozlog 22:12:05 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:12:05 INFO - Running setup.py install for moznetwork 22:12:05 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:12:05 INFO - Running setup.py install for mozprocess 22:12:05 INFO - Running setup.py install for mozprofile 22:12:05 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:12:05 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:12:05 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:12:05 INFO - Running setup.py install for mozrunner 22:12:05 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:12:05 INFO - Running setup.py install for mozscreenshot 22:12:05 INFO - Running setup.py install for moztest 22:12:06 INFO - Running setup.py install for mozversion 22:12:06 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:12:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:12:06 INFO - Cleaning up... 22:12:06 INFO - Return code: 0 22:12:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:12:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:12:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:12:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:12:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:12:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:06 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 0x7f89f5df5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14238d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b28b0>, '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 0x14b37b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b3c60>, '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': '4ac8d263c7293b36a1be1aed000001be-1458787044.235786-1166472986', '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 22:12:06 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 22:12:06 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 22:12:06 INFO - Using env: {'DISPLAY': ':0', 22:12:06 INFO - 'HOME': '/home/cltbld', 22:12:06 INFO - 'LANG': 'en_US.UTF-8', 22:12:06 INFO - 'LANGUAGE': 'en_US:en', 22:12:06 INFO - 'LOGNAME': 'cltbld', 22:12:06 INFO - 'MAIL': '/var/mail/cltbld', 22:12:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:12:06 INFO - 'MOZ_NO_REMOTE': '1', 22:12:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:12:06 INFO - 'NO_EM_RESTART': '1', 22:12:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:12:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:12:06 INFO - 'PWD': '/builds/slave/test-pgo', 22:12:06 INFO - 'SHELL': '/bin/bash', 22:12:06 INFO - 'SHLVL': '1', 22:12:06 INFO - 'TERM': 'linux', 22:12:06 INFO - 'TMOUT': '86400', 22:12:06 INFO - 'USER': 'cltbld', 22:12:06 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1458787044.235786-1166472986', 22:12:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:12:06 INFO - '_': '/tools/buildbot/bin/python'} 22:12:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:12:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:12:06 INFO - Running setup.py (path:/tmp/pip-S4IprA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:12:06 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)) 22:12:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:12:06 INFO - Running setup.py (path:/tmp/pip-uYhH7y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:12:06 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)) 22:12:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:12:06 INFO - Running setup.py (path:/tmp/pip-XzCqln-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:12:06 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)) 22:12:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:12:06 INFO - Running setup.py (path:/tmp/pip-LqS3ph-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:12:06 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)) 22:12:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:12:06 INFO - Running setup.py (path:/tmp/pip-vELHYA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:12:06 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)) 22:12:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:12:06 INFO - Running setup.py (path:/tmp/pip-cwtHkD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:12:06 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)) 22:12:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:12:06 INFO - Running setup.py (path:/tmp/pip-G8oNp6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:12:06 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)) 22:12:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:12:06 INFO - Running setup.py (path:/tmp/pip-uS9Xaa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:12:06 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)) 22:12:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:12:06 INFO - Running setup.py (path:/tmp/pip-qQ6tBQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:12:07 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)) 22:12:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:12:07 INFO - Running setup.py (path:/tmp/pip-arlmgT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:12:07 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)) 22:12:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:12:07 INFO - Running setup.py (path:/tmp/pip-GB3lmo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:12:07 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)) 22:12:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:12:07 INFO - Running setup.py (path:/tmp/pip-HoXu8g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:12:07 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)) 22:12:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:12:07 INFO - Running setup.py (path:/tmp/pip-QkhElX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:12:07 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)) 22:12:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:12:07 INFO - Running setup.py (path:/tmp/pip-UOFD5d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:12:07 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)) 22:12:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:12:07 INFO - Running setup.py (path:/tmp/pip-k6E08l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:12:07 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)) 22:12:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:12:07 INFO - Running setup.py (path:/tmp/pip-2t7Jo1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:12:07 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)) 22:12:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:12:07 INFO - Running setup.py (path:/tmp/pip-97qafK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:12:07 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)) 22:12:07 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)) 22:12:07 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)) 22:12:07 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)) 22:12:07 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)) 22:12:07 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)) 22:12:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:12:07 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 22:12:07 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 22:12:07 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 22:12:07 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 22:12:07 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 22:12:07 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 22:12:09 INFO - Downloading blessings-1.6.tar.gz 22:12:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:12:09 INFO - Installing collected packages: blessings 22:12:09 INFO - Running setup.py install for blessings 22:12:09 INFO - Successfully installed blessings 22:12:09 INFO - Cleaning up... 22:12:09 INFO - Return code: 0 22:12:09 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:12:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:12:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:12:09 INFO - Reading from file tmpfile_stdout 22:12:09 INFO - Current package versions: 22:12:09 INFO - argparse == 1.2.1 22:12:09 INFO - blessings == 1.6 22:12:09 INFO - blobuploader == 1.2.4 22:12:09 INFO - docopt == 0.6.1 22:12:09 INFO - manifestparser == 1.1 22:12:09 INFO - mozInstall == 1.12 22:12:09 INFO - mozcrash == 0.17 22:12:09 INFO - mozdebug == 0.1 22:12:09 INFO - mozdevice == 0.48 22:12:09 INFO - mozfile == 1.2 22:12:09 INFO - mozhttpd == 0.7 22:12:09 INFO - mozinfo == 0.9 22:12:09 INFO - mozleak == 0.1 22:12:09 INFO - mozlog == 3.1 22:12:09 INFO - moznetwork == 0.27 22:12:09 INFO - mozprocess == 0.22 22:12:09 INFO - mozprofile == 0.28 22:12:09 INFO - mozrunner == 6.11 22:12:09 INFO - mozscreenshot == 0.1 22:12:09 INFO - mozsystemmonitor == 0.0 22:12:09 INFO - moztest == 0.7 22:12:09 INFO - mozversion == 1.4 22:12:09 INFO - psutil == 3.1.1 22:12:09 INFO - requests == 1.2.3 22:12:09 INFO - wsgiref == 0.1.2 22:12:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:12:09 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')]} 22:12:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:12:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:09 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')]} 22:12:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:12:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:09 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 0x7f89f5df5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14238d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b28b0>, '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 0x14b37b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b3c60>, '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': '4ac8d263c7293b36a1be1aed000001be-1458787044.235786-1166472986', '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 22:12:09 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 22:12:09 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 22:12:09 INFO - Using env: {'DISPLAY': ':0', 22:12:09 INFO - 'HOME': '/home/cltbld', 22:12:09 INFO - 'LANG': 'en_US.UTF-8', 22:12:09 INFO - 'LANGUAGE': 'en_US:en', 22:12:09 INFO - 'LOGNAME': 'cltbld', 22:12:09 INFO - 'MAIL': '/var/mail/cltbld', 22:12:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:12:09 INFO - 'MOZ_NO_REMOTE': '1', 22:12:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:12:09 INFO - 'NO_EM_RESTART': '1', 22:12:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:12:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:12:09 INFO - 'PWD': '/builds/slave/test-pgo', 22:12:09 INFO - 'SHELL': '/bin/bash', 22:12:09 INFO - 'SHLVL': '1', 22:12:09 INFO - 'TERM': 'linux', 22:12:09 INFO - 'TMOUT': '86400', 22:12:09 INFO - 'USER': 'cltbld', 22:12:09 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1458787044.235786-1166472986', 22:12:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:12:09 INFO - '_': '/tools/buildbot/bin/python'} 22:12:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:12:10 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)) 22:12:10 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)) 22:12:10 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)) 22:12:10 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)) 22:12:10 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)) 22:12:10 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)) 22:12:10 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)) 22:12:10 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)) 22:12:10 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)) 22:12:10 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)) 22:12:10 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)) 22:12:10 INFO - Cleaning up... 22:12:10 INFO - Return code: 0 22:12:10 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:12: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')]} 22:12:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:12:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12: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')]} 22:12:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:12:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89f5df5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14238d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b28b0>, '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 0x14b37b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b3c60>, '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': '4ac8d263c7293b36a1be1aed000001be-1458787044.235786-1166472986', '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 22:12:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 22:12:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:12:10 INFO - Using env: {'DISPLAY': ':0', 22:12:10 INFO - 'HOME': '/home/cltbld', 22:12:10 INFO - 'LANG': 'en_US.UTF-8', 22:12:10 INFO - 'LANGUAGE': 'en_US:en', 22:12:10 INFO - 'LOGNAME': 'cltbld', 22:12:10 INFO - 'MAIL': '/var/mail/cltbld', 22:12:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:12:10 INFO - 'MOZ_NO_REMOTE': '1', 22:12:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:12:10 INFO - 'NO_EM_RESTART': '1', 22:12:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:12:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:12:10 INFO - 'PWD': '/builds/slave/test-pgo', 22:12:10 INFO - 'SHELL': '/bin/bash', 22:12:10 INFO - 'SHLVL': '1', 22:12:10 INFO - 'TERM': 'linux', 22:12:10 INFO - 'TMOUT': '86400', 22:12:10 INFO - 'USER': 'cltbld', 22:12:10 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1458787044.235786-1166472986', 22:12:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:12:10 INFO - '_': '/tools/buildbot/bin/python'} 22:12:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:12:10 INFO - Downloading/unpacking jsonschema 22:12:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:12:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:12:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:12:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:12:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:12:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:12:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:12:12 INFO - Downloading/unpacking functools32 (from jsonschema) 22:12:12 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 22:12:12 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 22:12:12 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 22:12:12 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 22:12:12 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 22:12:12 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 22:12:12 INFO - Downloading functools32-3.2.3-2.tar.gz 22:12:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:12:12 INFO - warning: no files found matching '*.txt' 22:12:12 INFO - no previously-included directories found matching 'build' 22:12:12 INFO - no previously-included directories found matching 'dist' 22:12:12 INFO - no previously-included directories found matching '.git*' 22:12:12 INFO - Installing collected packages: jsonschema, functools32 22:12:12 INFO - Running setup.py install for functools32 22:12:12 INFO - warning: no files found matching '*.txt' 22:12:12 INFO - no previously-included directories found matching 'build' 22:12:12 INFO - no previously-included directories found matching 'dist' 22:12:12 INFO - no previously-included directories found matching '.git*' 22:12:12 INFO - Successfully installed jsonschema functools32 22:12:12 INFO - Cleaning up... 22:12:12 INFO - Return code: 0 22:12:12 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:12:12 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')]} 22:12:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:12:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:12 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')]} 22:12:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:12:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:12 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 0x7f89f5df5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14238d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b28b0>, '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 0x14b37b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b3c60>, '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': '4ac8d263c7293b36a1be1aed000001be-1458787044.235786-1166472986', '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 22:12:12 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 22:12:12 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 22:12:12 INFO - Using env: {'DISPLAY': ':0', 22:12:12 INFO - 'HOME': '/home/cltbld', 22:12:12 INFO - 'LANG': 'en_US.UTF-8', 22:12:12 INFO - 'LANGUAGE': 'en_US:en', 22:12:12 INFO - 'LOGNAME': 'cltbld', 22:12:12 INFO - 'MAIL': '/var/mail/cltbld', 22:12:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:12:12 INFO - 'MOZ_NO_REMOTE': '1', 22:12:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:12:12 INFO - 'NO_EM_RESTART': '1', 22:12:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:12:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:12:12 INFO - 'PWD': '/builds/slave/test-pgo', 22:12:12 INFO - 'SHELL': '/bin/bash', 22:12:12 INFO - 'SHLVL': '1', 22:12:12 INFO - 'TERM': 'linux', 22:12:12 INFO - 'TMOUT': '86400', 22:12:12 INFO - 'USER': 'cltbld', 22:12:12 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1458787044.235786-1166472986', 22:12:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:12:12 INFO - '_': '/tools/buildbot/bin/python'} 22:12:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:12:12 INFO - Downloading/unpacking flake8 22:12:12 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 22:12:12 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 22:12:12 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 22:12:12 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 22:12:12 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 22:12:12 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 22:12:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:12:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:12: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 22:12: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 22:12: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 22:12: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 22:12: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 22:12: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 22:12:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:12:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:12: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 22:12: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 22:12: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 22:12: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 22:12: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 22:12: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 22:12:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:12:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:12:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:12:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:12:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:12:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:12:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:12:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:12:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:12:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:12:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:12:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:12:15 INFO - no previously-included directories found matching 'docs/_build' 22:12:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:12:15 INFO - Running setup.py install for pep8 22:12:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:12:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:12:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:12:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:12:15 INFO - no previously-included directories found matching 'docs/_build' 22:12:15 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:12:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:12:15 INFO - Cleaning up... 22:12:15 INFO - Return code: 0 22:12:15 INFO - Running post-action listener: _resource_record_post_action 22:12:15 INFO - Running post-action listener: _start_resource_monitoring 22:12:15 INFO - Starting resource monitoring. 22:12:15 INFO - ##### 22:12:15 INFO - ##### Running install step. 22:12:15 INFO - ##### 22:12:15 INFO - Running pre-action listener: _resource_record_pre_action 22:12:15 INFO - Running main action method: install 22:12:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:12:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:12:15 INFO - Reading from file tmpfile_stdout 22:12:15 INFO - Detecting whether we're running mozinstall >=1.0... 22:12:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:12:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:12:15 INFO - Reading from file tmpfile_stdout 22:12:15 INFO - Output received: 22:12:15 INFO - Usage: mozinstall [options] installer 22:12:15 INFO - Options: 22:12:15 INFO - -h, --help show this help message and exit 22:12:15 INFO - -d DEST, --destination=DEST 22:12:15 INFO - Directory to install application into. [default: 22:12:15 INFO - "/builds/slave/test-pgo"] 22:12:15 INFO - --app=APP Application being installed. [default: firefox] 22:12:15 INFO - mkdir: /builds/slave/test-pgo/build/application 22:12:15 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'] 22:12:15 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 22:12:32 INFO - Reading from file tmpfile_stdout 22:12:32 INFO - Output received: 22:12:32 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:12:32 INFO - Running post-action listener: _resource_record_post_action 22:12:32 INFO - ##### 22:12:32 INFO - ##### Running run-tests step. 22:12:32 INFO - ##### 22:12:32 INFO - Running pre-action listener: _resource_record_pre_action 22:12:32 INFO - Running main action method: run_tests 22:12:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:12:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:12:32 INFO - Python 2.7.3 22:12:32 INFO - Return code: 0 22:12:32 INFO - grabbing minidump binary from tooltool 22:12:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:12:32 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 0x14b28b0>, '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 0x14b37b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b3c60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:12:32 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 22:12:32 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 22:12:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:12:32 INFO - Return code: 0 22:12:32 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:12:32 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:12:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:12:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:12:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:12:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:12:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:12:33 INFO - Return code: 0 22:12:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DC7IPQZhRDeCkRNshbNrbA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 22:12:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DC7IPQZhRDeCkRNshbNrbA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --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 22:12:33 INFO - Using env: {'DISPLAY': ':0', 22:12:33 INFO - 'HOME': '/home/cltbld', 22:12:33 INFO - 'LANG': 'en_US.UTF-8', 22:12:33 INFO - 'LANGUAGE': 'en_US:en', 22:12:33 INFO - 'LOGNAME': 'cltbld', 22:12:33 INFO - 'MAIL': '/var/mail/cltbld', 22:12:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:12:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:12:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:12:33 INFO - 'MOZ_NO_REMOTE': '1', 22:12:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:12:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:12:33 INFO - 'NO_EM_RESTART': '1', 22:12:33 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:12:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:12:33 INFO - 'PWD': '/builds/slave/test-pgo', 22:12:33 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:12:33 INFO - 'SHELL': '/bin/bash', 22:12:33 INFO - 'SHLVL': '1', 22:12:33 INFO - 'TERM': 'linux', 22:12:33 INFO - 'TMOUT': '86400', 22:12:33 INFO - 'USER': 'cltbld', 22:12:33 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1458787044.235786-1166472986', 22:12:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:12:33 INFO - '_': '/tools/buildbot/bin/python'} 22:12:33 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DC7IPQZhRDeCkRNshbNrbA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 22:12:33 INFO - mozversion application_buildid: 20160323193423 22:12:33 INFO - mozversion application_changeset: c7192c4eecd0657907c4a40ac88db34298b6cc10 22:12:33 INFO - mozversion application_display_name: Nightly 22:12:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:12:33 INFO - mozversion application_name: Firefox 22:12:33 INFO - mozversion application_remotingname: firefox 22:12:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:12:33 INFO - mozversion application_vendor: Mozilla 22:12:33 INFO - mozversion application_version: 48.0a1 22:12:33 INFO - mozversion platform_buildid: 20160323193423 22:12:33 INFO - mozversion platform_changeset: c7192c4eecd0657907c4a40ac88db34298b6cc10 22:12:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:12:33 INFO - mozversion platform_version: 48.0a1 22:12:33 INFO - using testdate: 1458796353 22:12:33 INFO - actual date: 1458796353 22:12:33 INFO - starting webserver on 'localhost:39306' 22:12:33 INFO - SUITE-START | Running 2 tests 22:12:33 INFO - TEST-START | dromaeo_css 22:12:33 INFO - operating with platform_type : linux_ 22:12:33 INFO - Initialising browser for dromaeo_css test... 22:12:33 INFO - TEST-INFO | started process 23609 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpt9dfTW/profile http://localhost:39306/getInfo.html) 22:12:37 INFO - PROCESS | 23609 | __metrics Screen width/height:1600/1200 22:12:37 INFO - PROCESS | 23609 | colorDepth:24 22:12:37 INFO - PROCESS | 23609 | Browser inner width/height: 1024/697 22:12:37 INFO - PROCESS | 23609 | __metrics 22:12:38 ERROR - PROCESS | 23609 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:12:39 INFO - TEST-INFO | 23609: exit 0 22:12:39 INFO - Browser initialized. 22:12:39 INFO - Running cycle 1/1 for dromaeo_css test... 22:12:39 INFO - TEST-INFO | started process 23703 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpt9dfTW/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:12:50 INFO - PROCESS | 23703 | RSS: Main: 156176384 22:12:50 INFO - PROCESS | 23703 | 22:13:42 INFO - PROCESS | 23703 | 1458796422322 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] 22:15:48 INFO - PROCESS | 23703 | Cycle 1(1): loaded http://localhost:39306/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39306/tests/dromaeo/cssquery-ext.html) 22:15:49 INFO - PROCESS | 23703 | RSS: Main: 262991872 22:15:49 INFO - PROCESS | 23703 | 22:18:51 INFO - PROCESS | 23703 | Cycle 1(1): loaded http://localhost:39306/tests/dromaeo/cssquery-ext.html (next: http://localhost:39306/tests/dromaeo/cssquery-jquery.html) 22:18:52 INFO - PROCESS | 23703 | RSS: Main: 238067712 22:18:52 INFO - PROCESS | 23703 | 22:21:54 INFO - PROCESS | 23703 | Cycle 1(1): loaded http://localhost:39306/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39306/tests/dromaeo/cssquery-mootools.html) 22:21:54 INFO - PROCESS | 23703 | RSS: Main: 233512960 22:21:54 INFO - PROCESS | 23703 | 22:24:56 INFO - PROCESS | 23703 | Cycle 1(1): loaded http://localhost:39306/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39306/tests/dromaeo/cssquery-prototype.html) 22:24:57 INFO - PROCESS | 23703 | RSS: Main: 217329664 22:24:57 INFO - PROCESS | 23703 | 22:27:59 INFO - PROCESS | 23703 | Cycle 1(1): loaded http://localhost:39306/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39306/tests/dromaeo/cssquery-yui.html) 22:28:00 INFO - PROCESS | 23703 | RSS: Main: 223510528 22:28:00 INFO - PROCESS | 23703 | 22:31:02 INFO - PROCESS | 23703 | Cycle 1(1): loaded http://localhost:39306/tests/dromaeo/cssquery-yui.html (next: http://localhost:39306/tests/dromaeo/cssquery-dojo.html) 22:31:02 INFO - PROCESS | 23703 | RSS: Main: 266878976 22:31:02 INFO - PROCESS | 23703 | 22:31:02 INFO - PROCESS | 23703 | __start_tp_report 22:31:02 INFO - PROCESS | 23703 | _x_x_mozilla_page_load 22:31:02 INFO - PROCESS | 23703 | _x_x_mozilla_page_load_details 22:31:02 INFO - PROCESS | 23703 | |i|pagename|runs| 22:31:02 INFO - PROCESS | 23703 | |0;dojo.html;2988.7310142087213;3014.924626884329;3063.295442048329;3066.3867226554694;3093.644230913445;5014.849554513361;5127.820526281581;5139.563137133344;5194.065068287707;5205.531502164805;5090.541851233388;5158.871028224296;5159.845204643867;5226.216067589863;5249.86875328117;4693.530646935296;4727.66906316558;4803.5676789088975;4830.444498882638;4854.8300809471675;4562.589366956973;4782;4813.157697402958;4838.685485443435;4841.951580484185;4713.5993440557595;4749.145153872284;4750.738709370983;4755.595774359149;4797.448293446246;4753.025629745928;4754.524547545252;4778.283257511366;4781.6891902026255;4803.447603525605;4602.125596136723;4691.953080469186;4745.976270118627;4749;4796.400449943757;5134.717590532519;5160.071187186305;5163.277141200235;5185.585153187773;5185.922211166836;5530.087535556629;5557.5553955683445;5563.054280772238;5567.359753628344;5611.13027480737;5400.135978243501;5455.099908515091;5535.169724541311;5552.888942221133;5570.220169176318;5146.794128234867;5196.636235463481;5203.895922081575;5211.03595834768;5211.739413029333;5645.633033852787;5662.631928924607;5669.262995810518;5670.489655930986;5676.602637815396;5308.761105750251;5420.593455490854;5439.809606663748;5484.424135465719;5516.089845175581;5481.671099733949;5493.7802487900035;5494.038543254915;5494.2857428534835;5499.450054994549;5369;5473.8357849264585;5476.342838859362;5484.067708489566;5521;5495.807646732345;5549.334079910436;5555.77776888928;5580.358258800209;5598.2442370280305;4073.7555746655294;4074.0425999890003;4089.9182016359505;4113.856015039519;4116.650084742771;3682.668559829628;3744.85020599173;3782.924341513154;3788.6969042476535;3800.5439347278502;5129;5148.665336753099;5151.459096794858;5162.793488260502;5201.193814958688;5414.07960646691;5463.4263402342185;5463.535599474089;5470.56235501159;5522.061249587579;5036.748162591855;5161.716105614152;5178.844634660966;5246.842594722164;5282.260483532308;4635.2120139576355;4641.628669706415;4646.140464014168;4655.604273636779;4725;5741.397153298927;5751.769929202868;5754.223179870663;5754.568407369464;5755.65466072037;5366.543843773323;5548.4451554845;5561.610687251854;5646.3506696728755;5660.009498337692;5696.829095127153;5722.971385143048;5727.7422515986045;5730.684812335361;5740.913886291625;5433.212184233343;5437.945620543744;5439.619226654097;5442.755076021668;5446.373667028184;5337.199420087018;5514.558835293086;5585.078462053716;5602.1036634138345;5638.407967163553;5402.054640437987;5415.4313797050745;5415.756290966995;5416.7020813855615;5418.674879507243;5267.420583735862;5368.785248590013;5372.221027951004;5378.462153784747;5421;5252.395974462986;5256;5288.3918349390315;5290.735463226746;5341.626086174086;5401.810936617199;5409.648372855751;5430.185472179047;5442.619016668954;5444.26502422168;5178.119719647593;5231.450697676842;5310.097283461898;5331.680099194061;5380.596455265949 22:31:02 INFO - PROCESS | 23703 | |1;ext.html;560.0646919644194;584.1500616602841;586.2964442668797;600.1897438458083;624.9625022498648;29701.702982970164;38690;39000.609993900056;39344.99999999996;39362.40956385649;41263.79368103163;41370;41601.58398416015;41741.79129104358;41762.58237417625;7359.3744531714865;8529.402941794076;8704.912950870505;8710.738677839643;10084.445355505444;10140.746481337988;10308.433036183007;10308.948455257712;10311;10316.277860549764;10284.794304113913;10316.948415257913;10368.170546356274;10389.584416623364;10417.531211095518;7418.925810741905;10271.383716976969;10477.528511217013;10739.946300268526;10743.19426043042;10182.796344073151;10291.331063480924;10301.175905927508;10312.381257124596;10320.329178603366;38071;38130;38533.229335413416;38573.80713096417;38647.806760966014;3276.5576647152807;3366.7306615470948;3400.591928968515;3459.8616055357757;3549.94675079874;31952.840235798903;32139;32415.6758432415;32469;32711.509327359872;4081.7346872453195;4195.937060944088;4216.7259128156575;4225.260579398624;4240.173166232586;317145;318239;318406;318699;318794;59954.10068848971;60019.899303524166;60436.395636043955;60480.09279860806;60536.09195862066;63908.680456597416;64003;64308.35691643117;64339;64371.678141608994;15404.61488462775;15411.691766164615;15417;15417.229138543027;15417.922910385601;11767.058635309155;11785.764284714258;11811.232269902428;11811.822822657667;11818.113641476752;19394.806051939584;19908.203671853254;19931.20275189005;19946.70079948802;20004.399868003984;6581.736730530821;7998.5600791957;8116.080444504188;8189.099199088096;8312;1146.9276226728036;1159.252282277926;1178.6522975722182;1196.3061424373843;1265.3167289663663;32560.511592326133;32576.02271931846;32724.836375818446;32738.672613273564;33312.3337533248;1136.0968030415838;1195.5576436718295;1201.2818981647422;1216.2702378572963;1245.875412458765;16921.238544265536;16929.576760580836;16932.830671693126;16959.15204239783;16959.576010599587;373976;377051;378440;378777;380111;56238.813730489615;56561.434385655615;56764;57055.14417283744;57077.429225708045;1088.6353071721062;1326.635175326793;1416.6954104867502;1419.0775995602735;1428.649980754701;28075.805975894524;29963.700362996093;30220.546691800082;30581.694183058775;30766.538501922936;41191;41439.7928010358;41637.37543936904;41669.374959375025;41701.37447938344;191934;192300;192699;192801;193026;30365.392692146474;32196.517052243766;35923.46114808332;35946.8202658985;35987.820060899525;40493.1901361977;41412.585874140874;41532.58467415408;41961.16077678368;42048.789756051025;35049.474257886664;35092.64907350996;35099;35354;35667.46498802572;35439.46840797442;35558.46662300016;35675.28649427049;35817.82091089632;36001.81999089988;38761.4185787219;38808.80595597004;38967.415488767125;39086.4137037939;39574;33575.83212084022;34713;34731.82634086914;34812.477812833335;34996.300073998886;26923.461530768884;27099.86450067737;27271.909123635625;27300;27614 22:31:02 INFO - PROCESS | 23703 | |2;jquery.html;348.97401639180805;358.5500197252448;358.7237826873307;363.88355726167623;366.46313151233454;17705.291788328468;17728;19137.138828752704;19156.329528466507;19203.519912002208;17774;18443.72334414985;19151.329703460382;19155.61688766224;19186.520336991583;5465.699386533739;5596.608237423362;5634.605577609569;5634.830955071334;5635.408282130379;3979.9403008954887;5506.697131657757;5853.76584936602;6075.878482430348;6104.877902441948;6013.849653758669;6056.121862329959;6067.393260673942;6067.453929146376;6080.179175811253;5918.615290006157;5977.133315669225;6041.667708276043;6049.364816694272;6054.364291749369;3624.27514497099;5170.25031370453;5292.761825717814;5337.199420086979;5340.332458442695;20412.693809592718;20598;20749.377518674464;22219.22232721863;22225;2315.2822624986306;2349.3186975777003;2501.337145656384;2514.8742562871785;2794.23158631378;13614.93192534031;14018.369173387222;14034.298285085704;14133.081349712236;14469.638259043502;1979.544704717923;2017.1326329678232;2025.5341271507489;2034.4506983114477;2111.5671287386203;68664.6566767168;71555;71938.64030679865;72286.63856680735;72380.27619723788;10288.537015834156;10364.378137311785;10468.110210632181;10588.470576471145;10700.946495267473;13245.602631921058;13380.598582042554;13472.730545389037;13492.325383730971;13510.189388636516;8205.261526462647;8411.789705257295;8422.452540584842;8527.65889364431;8573.056963733985;8538.103499132625;8554.05905350411;8568.271696905707;8668.349873759493;8671.479711217347;6493.220813502316;6572.375624315682;6626;6645.900311495331;6693.096431981718;1652.107861754639;1715.9742603860952;1754.6052138268788;1778.0527229550378;1790.64187162568;944.6268723854039;992.7021893431942;1049.0768124050787;1098.9010989011028;1116.771061932302;17936.730949035777;17962.91018544925;17964.820351796316;18074.819251807578;18436;1021.4535223655308;1055.266589720137;1068.631322193842;1074.0977578833817;1094.9835752463719;10592.417417042137;10700.78598428027;11035.282706624044;11098.371477780966;11248.606298779503;474698;495494;502375;503442;511340;86339.56830215809;86628.56685716531;86898.69651955226;87676.56161719278;87844.5607771957;1081.5403453532217;1165.7668466306773;1192.1476144556684;1193.1945936492832;1198.6763573835017;16870.915645421694;16988.74516882223;17138.828611713725;17172.141392930054;17174.141292935554;38211.80894095512;38533;39679.60320396759;40336.59663403328;40483.59516404916;55484.16773748316;55549;55572;55837;55999;7776.572288524186;8127.593620318842;8154.836903261783;8233.83532329362;8317.251447369767;12849.614511564669;12975.545855894998;12980.286084265455;13256;13364.665883352995;11393.54425822991;11519.76960460803;11530.192886497865;11691.649250522498;11746.530138794353;10761.515731792244;11434.19960602783;11569.6529104127;11656.273247889307;11666.300021998708;11266.605668801552;11909.702257443632;11965.102617303563;12038.097142714156;12058.276503409823;8156.143604921398;8161.224683655043;8184.345252379676;8207.589620518831;8286.337093032422;8555.657773688983;11318.773624527628;11577.421128943352;11684.415779210836;11864.76270474603 22:31:02 INFO - PROCESS | 23703 | |3;mootools.html;1224.3266203588034;1446.8914831387644;1450.129922046772;1625.886187966842;1820.918058687359;7371.115466144063;7844.686212551498;7847.25451082147;7850.0579930408285;7854.214578542143;7592.240775922405;7763.301302882739;7763.340116090139;7763.495372800764;7764.378849692025;1783.8929664220123;1828.9176987035548;2151.4406254373857;2167.729033870766;2183.366823621148;2039.7144399784042;2043.9284625038126;2049.333966460899;2049.80526849949;2050.1389416445054;2148.742150941889;2159.147136880939;2160.82713382929;2169.078141789741;2222.344408399526;2181.7709140540333;2208.977910220893;2215.4018415028013;2217.2350539064078;2218.4121207879925;2205.7022301989186;2219.6448568229007;2223.2774348336693;2225.6105181593157;2231.854929429598;7891;7930.206979302081;7951.244631759973;7957.084935232465;7962.960185199037;4546.158960592301;4645.349651048856;4651.930221046653;4652.860414187579;4654.837080702193;3081.984590077058;3159.462891308483;3285.901422957315;3288.8355582221034;3299.026787097812;960.8750862387915;984.1782111936542;1007.4811472091878;1014.5282443663732;1023.8515415264745;10901;10918.727031824188;10922.836157457645;10927.453627318602;10929.672109836718;4120.587941205856;4160.583941605815;4194.790260486963;4244.533101358848;4256.553061928515;9350.812983740423;9362.25101991839;9372.484513351832;9373.765655858659;9378.062193780568;4791.688540244873;4809.735464549413;4809.78355973982;4832;4839.564439200489;3815.8855234343014;4322.891927701769;4400.977995110004;4442.111577684476;4485.910281794346;3615.475756015363;3676;3698;3723.832427540767;3723.9255214896093;1130.2427373659668;1137.6928229378022;1138.3283862521153;1143.6454699043156;1143.782681290552;1131.4286285425972;1139.943002849854;1141.08713029576;1330.6806366471976;1400.4958215042577;7563.130240022468;7613.42899282556;7654.923450765533;7702.460827742117;7704.075510938611;396.6331143692131;401.90354314964196;403.4996604210816;406.8413318805668;409.3123552431943;5942.078977758368;5979.730912108966;5981.162637230791;6000.909986350208;6032.849178770566;9323.20752736025;9579.13787759105;9787.070228328297;9857;9898.950505247427;9664.613415463444;9723.367981081206;9760.56077476501;9762.414255144715;9768.36505627132;7265.927340726631;7440.813979650552;7469.962650186714;7479.102507699002;7534.773956781305;7456.888146677696;7485.625718714152;7519.1728909818785;7549.547027178387;7551.169371369255;8398.790030249293;8480.787980300542;8590.1839325264;8741.475511469333;8744.081871403665;8762.430442021248;8804.735857924272;8905.421147625642;9002;9061.09389061115;5604.971975140098;6639.170103737033;6792.830179245559;6930.653467326512;7025.789226323219;7113.039739635083;7160.964195178991;7168.569885806868;7193.136823581203;7206.639668016683;6637.103990961352;6849.1438570178725;6896.586204827727;6934.271901450476;7044.471664625071;6455.3221911700475;6483.805485835433;6495.935040649533;6550.6069635822005;6576.8355791105605;7006.859862802614;7071.893921591078;7081.00865878767;7140.428765698628;7146.857062858609;6523.64119973406;6561.343865613591;6568.113304703995;6606.6366349849295;6608.240052393844;6778.3221677831825;6843.828904277433;6860.6912688930115;6861.862762744618;6863.725450981905 22:31:02 INFO - PROCESS | 23703 | |4;prototype.html;322.45827010622145;325.53123502156905;329.755980574375;332.55935884952436;333.2734638488096;6074.483668888139;6118.755249790009;6120.755169793214;6151.815445536636;6156.784512542062;5994.310654274749;6034.094885767137;6034.97405441075;6048.334683184846;6049;4372.803223854934;4516.954830451687;4589.403377560912;4593.356930029799;4640.164770341337;4592.425946756655;4600.608948239404;4618.653600979923;4621.191291523986;4637.860864174063;4576.610988066019;4590.724556526602;4599.632029437637;4602.9769851150695;4613.8154473821005;4301.26878430666;4508.368828364031;4592.058627981256;4599.770011499445;4625.444946606429;4014;4017.31705610047;4022.7184097113213;4023.396490526415;4031.778252196128;5806.65160090396;5808.157817116495;5809.419058094157;5829.883402331972;5830.62100963436;5318.468153184689;5325.733713314319;5333.280007199056;5333.679979201261;5347.893042139174;6366.840828979266;6367.6497792621385;6370.108184854124;6374;6379.489640828769;4185.91628167438;4273.081287523198;4282.743035417854;4312.762798046107;4459.397981272519;6606.273309935903;6689.23073846509;6722.563033402862;6751.763688270936;6761.661916904135;4397.84607538741;4432.180046691373;4441.68908176431;4444.3333499974615;4449.7997590108525;4494.37078808967;4495.303227999665;4496.752678602643;4497.370368148462;4497.965467942392;5252.789888404497;5259.868503287448;5261.631685781958;5266.710330931835;5270.156774916071;6196.628202307876;6399.840003999937;6458.451031662361;6462.127612772216;6463.7091330890225;1607.477569789823;1616.8302328255363;1625.268629116902;1625.5367220342146;1631.5676345768381;974.9025097490194;1057.259918057363;1069.8448724934997;1077.6389909380446;1086.190787863047;6117;6134.601250918676;6182.1345011698395;6201.81394558164;6215.440610345091;6595.307492713196;6600.669966501656;6604.405603495708;6613;6618.569792963442;6186.659733714689;6188.845278868064;6191.81424557264;6194.690265486708;6198.659073750897;3527.8412471438332;3557.964420355815;3565.5186549815962;3566.7681600695873;3573.874914377984;6685.164354455693;6828.760993365208;6846.7945961621235;6860.279670634612;6874.518783685194;6708.6310252936555;6749.358810912955;6750.5274630775375;6752.696128674123;6756.797296081126;6815.079964204868;6834.589924604539;6835.487338449537;6836.213835408892;6840.794776156723;6573.80278591643;6578.76974305897;6580.177477815273;6581.045748366556;6584.308647591934;6292.9370706294185;6499.837504062436;6503.122078519528;6513.023046542867;6514.413702766774;6765.42493888025;6813.080234168324;6823.249442561413;6836.453083753188;6836.692348844214;4550.294704320836;4551.453825540824;4556.134334476439;4556.521565235603;4560.794764235551;6548.541602087998;6565.212174539086;6570.868582628416;6571.211454625284;6571.638559879252;6329.177206963065;6407.71165297572;6412.326705695835;6416.422521973045;6419.325970773001;6416.422521973045;6493.415592596689;6494.7077381517;6501.057346684799;6504.1869766279215;6336.58812177207;6349.777757778455;6353.269374022047;6361.077643741724;6361.14124593174;6497.837554061186;6533.477321814148;6541.672916354068;6548.279689234085;6548.508861835287;5979.581429300081;6103.359147289649;6373.553851230369;6377.489800816016;6379.649119298483 22:31:02 INFO - PROCESS | 23703 | |5;yui.html;745.8321877577546;764.3083009876065;770.4529783853463;778.6807408962324;785.5012067337241;13478.865211347884;13718.108322959013;13719.931400342997;13723.725525489484;13750.106243094191;12120.454579543919;12649.17780344277;12679.4928202872;12696.301703406309;12707.682307942307;830.6345208108443;839.2656425627575;840.6553313141613;840.794005468661;841.154639587214;854.1543871567166;854.2738672128672;860.3375400941271;860.7202659135775;860.9827803443927;885.2475395913455;889.1330952321499;889.7642124836923;889.8264838356523;890.0387581412092;879.5118709116438;884.5754038061734;885.968991085309;886.0342226972599;887.041994645781;645.3191882563893;646.805958212539;648.3937518420292;648.5460177875506;648.7275344355382;12379.690507737288;12409.689757756038;12425.502979880885;12433;12474.064445166558;9990.45052522111;10374.481275936248;10502.054815066604;10560.841587376195;10598.78802423955;9870.45712485813;9909.603615855358;10012.899871001342;10078.143357814595;10365.689029329133;3656.323580137683;3667.229881724841;3673.3571624965525;3695.3902606069964;3750.043738846604;44796.552034479566;48658.51341486611;48696.269555956686;48769;48811.26783098292;10302.845457318146;10374.481275936172;10441.530131144116;10567.89432105669;10624.734381640366;16481.505554833373;16523.586910327336;16525.91737041331;16535.66928661444;16554.58613534671;7726.845463090706;7771.339436147878;8195.754127376189;8277.255047045795;8278.379121565908;4508.706934049276;4610.976945115253;4624.491305956342;4665.743384113838;4809.9038019240115;3119.5788568542957;3153.668864769212;3164.193130751644;3194.1535493094348;3205.6634053424523;615.230961298377;629.7197747002632;631.4601016131234;631.8641492079225;632.2128949457863;620.8044465993198;645.4642646603309;651.491836367634;662.5593980003243;666.919590263766;8270.586470676442;8550.102239264788;8652.134786521297;8660.30717542595;8945.46327220369;599.9520038396918;604.5828378418964;618.2797041446754;726.8800647893038;748.7042618165794;4112.177564487055;4142.689298302639;4188.6230239278;4212.662986961036;4228.746275223435;59495.40504594899;60205.39794601998;60416;60686.39313606896;60900.69549652223;50407.49592504101;52986.47013529892;53042.20436693453;53350.73324633352;53498.732506338;41593.37609935853;48732.26901596408;48872.5112748875;49355.75322123367;50348.244776328385;8581.570921453778;8853.468791872509;9077.044595353223;9118.544072796201;9253.306002049738;36738.63261367352;36941.44587831131;37816.62183378131;37973;38068.80965595154;42859.928501787705;43103.35344969765;48365;48550.271745923135;49572.50427495679;11662;11775.882241177822;11830.585929492427;11855.940720296689;12204;11952.70118247016;12325.506979721069;12390.256584604953;13011.21932684004;13086.607401777961;11291.548338066714;11440.48517816717;11621.709457263636;11771.764564708486;11965.820512692491;11782.646520604396;11876.704882634149;11894.821577676168;12033.939830300793;12195.878041219474;11651.41742912834;11737.35444550558;11837.467313971065;12184.20802647825;12245.816312755494;10016.59933602677;10199.34082515976;10253.538590763583;10298.3820970739;10382.377057376581;10209.591616335263;10243.436610986468;10281.12610428122;10332.896671033193;10333.379997200193 22:31:02 INFO - PROCESS | 23703 | __end_tp_report 22:31:02 INFO - PROCESS | 23703 | __start_cc_report 22:31:02 INFO - PROCESS | 23703 | _x_x_mozilla_cycle_collect,779 22:31:02 INFO - PROCESS | 23703 | __end_cc_report 22:31:02 INFO - PROCESS | 23703 | __startTimestamp1458797462815__endTimestamp 22:31:02 INFO - PROCESS | 23703 | 22:31:02 INFO - PROCESS | 23703 | ------- Summary: start ------- 22:31:02 INFO - PROCESS | 23703 | Number of tests: 6 22:31:02 INFO - PROCESS | 23703 | 22:31:02 INFO - PROCESS | 23703 | [#0] dojo.html Cycles:165 Average:5130.16 Median:5308.76 stddev:579.24 (10.9%) stddev-sans-first:556.13 22:31:02 INFO - PROCESS | 23703 | Values: 2988.7 3014.9 3063.3 3066.4 3093.6 5014.8 5127.8 5139.6 5194.1 5205.5 5090.5 5158.9 5159.8 5226.2 5249.9 4693.5 4727.7 4803.6 4830.4 4854.8 4562.6 4782.0 4813.2 4838.7 4842.0 4713.6 4749.1 4750.7 4755.6 4797.4 4753.0 4754.5 4778.3 4781.7 4803.4 4602.1 4692.0 4746.0 4749.0 4796.4 5134.7 5160.1 5163.3 5185.6 5185.9 5530.1 5557.6 5563.1 5567.4 5611.1 5400.1 5455.1 5535.2 5552.9 5570.2 5146.8 5196.6 5203.9 5211.0 5211.7 5645.6 5662.6 5669.3 5670.5 5676.6 5308.8 5420.6 5439.8 5484.4 5516.1 5481.7 5493.8 5494.0 5494.3 5499.5 5369.0 5473.8 5476.3 5484.1 5521.0 5495.8 5549.3 5555.8 5580.4 5598.2 4073.8 4074.0 4089.9 4113.9 4116.7 3682.7 3744.9 3782.9 3788.7 3800.5 5129.0 5148.7 5151.5 5162.8 5201.2 5414.1 5463.4 5463.5 5470.6 5522.1 5036.7 5161.7 5178.8 5246.8 5282.3 4635.2 4641.6 4646.1 4655.6 4725.0 5741.4 5751.8 5754.2 5754.6 5755.7 5366.5 5548.4 5561.6 5646.4 5660.0 5696.8 5723.0 5727.7 5730.7 5740.9 5433.2 5437.9 5439.6 5442.8 5446.4 5337.2 5514.6 5585.1 5602.1 5638.4 5402.1 5415.4 5415.8 5416.7 5418.7 5267.4 5368.8 5372.2 5378.5 5421.0 5252.4 5256.0 5288.4 5290.7 5341.6 5401.8 5409.6 5430.2 5442.6 5444.3 5178.1 5231.5 5310.1 5331.7 5380.6 22:31:02 INFO - PROCESS | 23703 | 22:31:02 INFO - PROCESS | 23703 | [#1] ext.html Cycles:180 Average:47335.02 Median:3383.66 stddev:80357.57 (2374.9%) stddev-sans-first:80506.25 22:31:02 INFO - PROCESS | 23703 | Values: 560.1 584.2 586.3 600.2 625.0 29701.7 38690.0 39000.6 39345.0 39362.4 41263.8 41370.0 41601.6 41741.8 41762.6 7359.4 8529.4 8704.9 8710.7 10084.4 10140.7 10308.4 10308.9 10311.0 10316.3 10284.8 10316.9 10368.2 10389.6 10417.5 7418.9 10271.4 10477.5 10739.9 10743.2 10182.8 10291.3 10301.2 10312.4 10320.3 38071.0 38130.0 38533.2 38573.8 38647.8 3276.6 3366.7 3400.6 3459.9 3549.9 31952.8 32139.0 32415.7 32469.0 32711.5 4081.7 4195.9 4216.7 4225.3 4240.2 317145.0 318239.0 318406.0 318699.0 318794.0 59954.1 60019.9 60436.4 60480.1 60536.1 63908.7 64003.0 64308.4 64339.0 64371.7 15404.6 15411.7 15417.0 15417.2 15417.9 11767.1 11785.8 11811.2 11811.8 11818.1 19394.8 19908.2 19931.2 19946.7 20004.4 6581.7 7998.6 8116.1 8189.1 8312.0 1146.9 1159.3 1178.7 1196.3 1265.3 32560.5 32576.0 32724.8 32738.7 33312.3 1136.1 1195.6 1201.3 1216.3 1245.9 16921.2 16929.6 16932.8 16959.2 16959.6 373976.0 377051.0 378440.0 378777.0 380111.0 56238.8 56561.4 56764.0 57055.1 57077.4 1088.6 1326.6 1416.7 1419.1 1428.6 28075.8 29963.7 30220.5 30581.7 30766.5 41191.0 41439.8 41637.4 41669.4 41701.4 191934.0 192300.0 192699.0 192801.0 193026.0 30365.4 32196.5 35923.5 35946.8 35987.8 40493.2 41412.6 41532.6 41961.2 42048.8 35049.5 35092.6 35099.0 35354.0 35667.5 35439.5 35558.5 35675.3 35817.8 36001.8 38761.4 38808.8 38967.4 39086.4 39574.0 33575.8 34713.0 34731.8 34812.5 34996.3 26923.5 27099.9 27271.9 27300.0 27614.0 22:31:02 INFO - PROCESS | 23703 | 22:31:02 INFO - PROCESS | 23703 | [#2] jquery.html Cycles:180 Average:28626.34 Median:22222.11 stddev:81713.28 (367.7%) stddev-sans-first:81914.92 22:31:02 INFO - PROCESS | 23703 | Values: 349.0 358.6 358.7 363.9 366.5 17705.3 17728.0 19137.1 19156.3 19203.5 17774.0 18443.7 19151.3 19155.6 19186.5 5465.7 5596.6 5634.6 5634.8 5635.4 3979.9 5506.7 5853.8 6075.9 6104.9 6013.8 6056.1 6067.4 6067.5 6080.2 5918.6 5977.1 6041.7 6049.4 6054.4 3624.3 5170.3 5292.8 5337.2 5340.3 20412.7 20598.0 20749.4 22219.2 22225.0 2315.3 2349.3 2501.3 2514.9 2794.2 13614.9 14018.4 14034.3 14133.1 14469.6 1979.5 2017.1 2025.5 2034.5 2111.6 68664.7 71555.0 71938.6 72286.6 72380.3 10288.5 10364.4 10468.1 10588.5 10700.9 13245.6 13380.6 13472.7 13492.3 13510.2 8205.3 8411.8 8422.5 8527.7 8573.1 8538.1 8554.1 8568.3 8668.3 8671.5 6493.2 6572.4 6626.0 6645.9 6693.1 1652.1 1716.0 1754.6 1778.1 1790.6 944.6 992.7 1049.1 1098.9 1116.8 17936.7 17962.9 17964.8 18074.8 18436.0 1021.5 1055.3 1068.6 1074.1 1095.0 10592.4 10700.8 11035.3 11098.4 11248.6 474698.0 495494.0 502375.0 503442.0 511340.0 86339.6 86628.6 86898.7 87676.6 87844.6 1081.5 1165.8 1192.1 1193.2 1198.7 16870.9 16988.7 17138.8 17172.1 17174.1 38211.8 38533.0 39679.6 40336.6 40483.6 55484.2 55549.0 55572.0 55837.0 55999.0 7776.6 8127.6 8154.8 8233.8 8317.3 12849.6 12975.5 12980.3 13256.0 13364.7 11393.5 11519.8 11530.2 11691.6 11746.5 10761.5 11434.2 11569.7 11656.3 11666.3 11266.6 11909.7 11965.1 12038.1 12058.3 8156.1 8161.2 8184.3 8207.6 8286.3 8555.7 11318.8 11577.4 11684.4 11864.8 22:31:02 INFO - PROCESS | 23703 | 22:31:02 INFO - PROCESS | 23703 | [#3] mootools.html Cycles:180 Average:5490.96 Median:6489.87 stddev:2949.85 (45.5%) stddev-sans-first:2940.69 22:31:02 INFO - PROCESS | 23703 | Values: 1224.3 1446.9 1450.1 1625.9 1820.9 7371.1 7844.7 7847.3 7850.1 7854.2 7592.2 7763.3 7763.3 7763.5 7764.4 1783.9 1828.9 2151.4 2167.7 2183.4 2039.7 2043.9 2049.3 2049.8 2050.1 2148.7 2159.1 2160.8 2169.1 2222.3 2181.8 2209.0 2215.4 2217.2 2218.4 2205.7 2219.6 2223.3 2225.6 2231.9 7891.0 7930.2 7951.2 7957.1 7963.0 4546.2 4645.3 4651.9 4652.9 4654.8 3082.0 3159.5 3285.9 3288.8 3299.0 960.9 984.2 1007.5 1014.5 1023.9 10901.0 10918.7 10922.8 10927.5 10929.7 4120.6 4160.6 4194.8 4244.5 4256.6 9350.8 9362.3 9372.5 9373.8 9378.1 4791.7 4809.7 4809.8 4832.0 4839.6 3815.9 4322.9 4401.0 4442.1 4485.9 3615.5 3676.0 3698.0 3723.8 3723.9 1130.2 1137.7 1138.3 1143.6 1143.8 1131.4 1139.9 1141.1 1330.7 1400.5 7563.1 7613.4 7654.9 7702.5 7704.1 396.6 401.9 403.5 406.8 409.3 5942.1 5979.7 5981.2 6000.9 6032.8 9323.2 9579.1 9787.1 9857.0 9899.0 9664.6 9723.4 9760.6 9762.4 9768.4 7265.9 7440.8 7470.0 7479.1 7534.8 7456.9 7485.6 7519.2 7549.5 7551.2 8398.8 8480.8 8590.2 8741.5 8744.1 8762.4 8804.7 8905.4 9002.0 9061.1 5605.0 6639.2 6792.8 6930.7 7025.8 7113.0 7161.0 7168.6 7193.1 7206.6 6637.1 6849.1 6896.6 6934.3 7044.5 6455.3 6483.8 6495.9 6550.6 6576.8 7006.9 7071.9 7081.0 7140.4 7146.9 6523.6 6561.3 6568.1 6606.6 6608.2 6778.3 6843.8 6860.7 6861.9 6863.7 22:31:02 INFO - PROCESS | 23703 | 22:31:02 INFO - PROCESS | 23703 | [#4] prototype.html Cycles:180 Average:5346.89 Median:6143.21 stddev:1627.90 (26.5%) stddev-sans-first:1588.19 22:31:02 INFO - PROCESS | 23703 | Values: 322.5 325.5 329.8 332.6 333.3 6074.5 6118.8 6120.8 6151.8 6156.8 5994.3 6034.1 6035.0 6048.3 6049.0 4372.8 4517.0 4589.4 4593.4 4640.2 4592.4 4600.6 4618.7 4621.2 4637.9 4576.6 4590.7 4599.6 4603.0 4613.8 4301.3 4508.4 4592.1 4599.8 4625.4 4014.0 4017.3 4022.7 4023.4 4031.8 5806.7 5808.2 5809.4 5829.9 5830.6 5318.5 5325.7 5333.3 5333.7 5347.9 6366.8 6367.6 6370.1 6374.0 6379.5 4185.9 4273.1 4282.7 4312.8 4459.4 6606.3 6689.2 6722.6 6751.8 6761.7 4397.8 4432.2 4441.7 4444.3 4449.8 4494.4 4495.3 4496.8 4497.4 4498.0 5252.8 5259.9 5261.6 5266.7 5270.2 6196.6 6399.8 6458.5 6462.1 6463.7 1607.5 1616.8 1625.3 1625.5 1631.6 974.9 1057.3 1069.8 1077.6 1086.2 6117.0 6134.6 6182.1 6201.8 6215.4 6595.3 6600.7 6604.4 6613.0 6618.6 6186.7 6188.8 6191.8 6194.7 6198.7 3527.8 3558.0 3565.5 3566.8 3573.9 6685.2 6828.8 6846.8 6860.3 6874.5 6708.6 6749.4 6750.5 6752.7 6756.8 6815.1 6834.6 6835.5 6836.2 6840.8 6573.8 6578.8 6580.2 6581.0 6584.3 6292.9 6499.8 6503.1 6513.0 6514.4 6765.4 6813.1 6823.2 6836.5 6836.7 4550.3 4551.5 4556.1 4556.5 4560.8 6548.5 6565.2 6570.9 6571.2 6571.6 6329.2 6407.7 6412.3 6416.4 6419.3 6416.4 6493.4 6494.7 6501.1 6504.2 6336.6 6349.8 6353.3 6361.1 6361.1 6497.8 6533.5 6541.7 6548.3 6548.5 5979.6 6103.4 6373.6 6377.5 6379.6 22:31:02 INFO - PROCESS | 23703 | 22:31:02 INFO - PROCESS | 23703 | [#5] yui.html Cycles:180 Average:14094.82 Median:24652.63 stddev:16496.95 (66.9%) stddev-sans-first:16512.77 22:31:02 INFO - PROCESS | 23703 | Values: 745.8 764.3 770.5 778.7 785.5 13478.9 13718.1 13719.9 13723.7 13750.1 12120.5 12649.2 12679.5 12696.3 12707.7 830.6 839.3 840.7 840.8 841.2 854.2 854.3 860.3 860.7 861.0 885.2 889.1 889.8 889.8 890.0 879.5 884.6 886.0 886.0 887.0 645.3 646.8 648.4 648.5 648.7 12379.7 12409.7 12425.5 12433.0 12474.1 9990.5 10374.5 10502.1 10560.8 10598.8 9870.5 9909.6 10012.9 10078.1 10365.7 3656.3 3667.2 3673.4 3695.4 3750.0 44796.6 48658.5 48696.3 48769.0 48811.3 10302.8 10374.5 10441.5 10567.9 10624.7 16481.5 16523.6 16525.9 16535.7 16554.6 7726.8 7771.3 8195.8 8277.3 8278.4 4508.7 4611.0 4624.5 4665.7 4809.9 3119.6 3153.7 3164.2 3194.2 3205.7 615.2 629.7 631.5 631.9 632.2 620.8 645.5 651.5 662.6 666.9 8270.6 8550.1 8652.1 8660.3 8945.5 600.0 604.6 618.3 726.9 748.7 4112.2 4142.7 4188.6 4212.7 4228.7 59495.4 60205.4 60416.0 60686.4 60900.7 50407.5 52986.5 53042.2 53350.7 53498.7 41593.4 48732.3 48872.5 49355.8 50348.2 8581.6 8853.5 9077.0 9118.5 9253.3 36738.6 36941.4 37816.6 37973.0 38068.8 42859.9 43103.4 48365.0 48550.3 49572.5 11662.0 11775.9 11830.6 11855.9 12204.0 11952.7 12325.5 12390.3 13011.2 13086.6 11291.5 11440.5 11621.7 11771.8 11965.8 11782.6 11876.7 11894.8 12033.9 12195.9 11651.4 11737.4 11837.5 12184.2 12245.8 10016.6 10199.3 10253.5 10298.4 10382.4 10209.6 10243.4 10281.1 10332.9 10333.4 22:31:02 INFO - PROCESS | 23703 | -------- Summary: end -------- 22:31:02 INFO - PROCESS | 23703 | 22:31:03 INFO - TEST-INFO | 23703: exit 0 22:31:03 INFO - TEST-OK | dromaeo_css | took 1109878ms 22:31:03 INFO - TEST-START | kraken 22:31:03 INFO - operating with platform_type : linux_ 22:31:03 INFO - Initialising browser for kraken test... 22:31:03 INFO - TEST-INFO | started process 23895 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJsNAzO/profile http://localhost:39306/getInfo.html) 22:31:07 INFO - PROCESS | 23895 | __metrics Screen width/height:1600/1200 22:31:07 INFO - PROCESS | 23895 | colorDepth:24 22:31:07 INFO - PROCESS | 23895 | Browser inner width/height: 1024/697 22:31:07 INFO - PROCESS | 23895 | __metrics 22:31:08 ERROR - PROCESS | 23895 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:31:08 INFO - PROCESS | 23895 | 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. 22:31:08 INFO - TEST-INFO | 23895: exit 0 22:31:08 INFO - Browser initialized. 22:31:08 INFO - Running cycle 1/1 for kraken test... 22:31:08 INFO - TEST-INFO | started process 23976 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJsNAzO/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:31:20 INFO - PROCESS | 23976 | RSS: Main: 155131904 22:31:20 INFO - PROCESS | 23976 | 22:31:23 INFO - PROCESS | 23976 | Cycle 1(1): loaded http://localhost:39306/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39306/tests/kraken/driver.html?testName=audio-beat-detection) 22:31:23 INFO - PROCESS | 23976 | RSS: Main: 196476928 22:31:23 INFO - PROCESS | 23976 | 22:31:26 INFO - PROCESS | 23976 | Cycle 1(1): loaded http://localhost:39306/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39306/tests/kraken/driver.html?testName=audio-dft) 22:31:26 INFO - PROCESS | 23976 | RSS: Main: 186294272 22:31:26 INFO - PROCESS | 23976 | 22:31:29 INFO - PROCESS | 23976 | Cycle 1(1): loaded http://localhost:39306/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39306/tests/kraken/driver.html?testName=audio-fft) 22:31:30 INFO - PROCESS | 23976 | RSS: Main: 169324544 22:31:30 INFO - PROCESS | 23976 | 22:31:32 INFO - PROCESS | 23976 | Cycle 1(1): loaded http://localhost:39306/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39306/tests/kraken/driver.html?testName=audio-oscillator) 22:31:32 INFO - PROCESS | 23976 | RSS: Main: 173318144 22:31:32 INFO - PROCESS | 23976 | 22:31:35 INFO - PROCESS | 23976 | Cycle 1(1): loaded http://localhost:39306/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39306/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:31:35 INFO - PROCESS | 23976 | RSS: Main: 174940160 22:31:35 INFO - PROCESS | 23976 | 22:31:38 INFO - PROCESS | 23976 | Cycle 1(1): loaded http://localhost:39306/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39306/tests/kraken/driver.html?testName=imaging-darkroom) 22:31:39 INFO - PROCESS | 23976 | RSS: Main: 175906816 22:31:39 INFO - PROCESS | 23976 | 22:31:42 INFO - PROCESS | 23976 | Cycle 1(1): loaded http://localhost:39306/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39306/tests/kraken/driver.html?testName=imaging-desaturate) 22:31:43 INFO - PROCESS | 23976 | RSS: Main: 175144960 22:31:43 INFO - PROCESS | 23976 | 22:31:45 INFO - PROCESS | 23976 | Cycle 1(1): loaded http://localhost:39306/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39306/tests/kraken/driver.html?testName=json-parse-financial) 22:31:46 INFO - PROCESS | 23976 | RSS: Main: 174600192 22:31:46 INFO - PROCESS | 23976 | 22:31:48 INFO - PROCESS | 23976 | Cycle 1(1): loaded http://localhost:39306/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39306/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:31:48 INFO - PROCESS | 23976 | RSS: Main: 185851904 22:31:48 INFO - PROCESS | 23976 | 22:31:50 INFO - PROCESS | 23976 | Cycle 1(1): loaded http://localhost:39306/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39306/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:31:50 INFO - PROCESS | 23976 | RSS: Main: 183189504 22:31:50 INFO - PROCESS | 23976 | 22:31:52 INFO - PROCESS | 23976 | Cycle 1(1): loaded http://localhost:39306/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39306/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:31:53 INFO - PROCESS | 23976 | RSS: Main: 197603328 22:31:53 INFO - PROCESS | 23976 | 22:31:55 INFO - PROCESS | 23976 | Cycle 1(1): loaded http://localhost:39306/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39306/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:31:56 INFO - PROCESS | 23976 | RSS: Main: 206467072 22:31:56 INFO - PROCESS | 23976 | 22:31:58 INFO - PROCESS | 23976 | Cycle 1(1): loaded http://localhost:39306/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39306/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:31:59 INFO - PROCESS | 23976 | RSS: Main: 203120640 22:31:59 INFO - PROCESS | 23976 | 22:32:01 INFO - PROCESS | 23976 | Cycle 1(1): loaded http://localhost:39306/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39306/tests/kraken/driver.html?testName=ai-astar) 22:32:01 INFO - PROCESS | 23976 | RSS: Main: 263036928 22:32:01 INFO - PROCESS | 23976 | 22:32:01 INFO - PROCESS | 23976 | __start_tp_report 22:32:01 INFO - PROCESS | 23976 | _x_x_mozilla_page_load 22:32:01 INFO - PROCESS | 23976 | _x_x_mozilla_page_load_details 22:32:01 INFO - PROCESS | 23976 | |i|pagename|runs| 22:32:01 INFO - PROCESS | 23976 | |0;ai-astar;109;109;104;109;111;110;98;109;108;109 22:32:01 INFO - PROCESS | 23976 | |1;audio-beat-detection;154;132;147;168;125;155;154;124;172;122 22:32:01 INFO - PROCESS | 23976 | |2;audio-dft;160;160;161;160;160;159;159;163;160;162 22:32:01 INFO - PROCESS | 23976 | |3;audio-fft;72;76;101;92;71;76;75;122;104;71 22:32:01 INFO - PROCESS | 23976 | |4;audio-oscillator;92;94;138;93;93;92;134;91;92;134 22:32:01 INFO - PROCESS | 23976 | |5;imaging-gaussian-blur;117;116;117;119;118;117;117;118;118;117 22:32:01 INFO - PROCESS | 23976 | |6;imaging-darkroom;145;145;145;145;145;145;146;145;146;145 22:32:01 INFO - PROCESS | 23976 | |7;imaging-desaturate;95;95;95;95;95;95;95;96;95;95 22:32:01 INFO - PROCESS | 23976 | |8;json-parse-financial;55;54;54;55;56;56;55;64;55;53 22:32:01 INFO - PROCESS | 23976 | |9;json-stringify-tinderbox;62;62;61;61;61;61;62;61;61;62 22:32:01 INFO - PROCESS | 23976 | |10;stanford-crypto-aes;77;77;78;77;78;78;77;86;77;77 22:32:01 INFO - PROCESS | 23976 | |11;stanford-crypto-ccm;117;114;110;115;114;108;108;110;108;109 22:32:01 INFO - PROCESS | 23976 | |12;stanford-crypto-pbkdf2;142;142;141;141;140;131;140;145;138;141 22:32:01 INFO - PROCESS | 23976 | |13;stanford-crypto-sha256-iterative;61;64;64;62;63;64;63;62;62;61 22:32:01 INFO - PROCESS | 23976 | __end_tp_report 22:32:01 INFO - PROCESS | 23976 | __start_cc_report 22:32:01 INFO - PROCESS | 23976 | _x_x_mozilla_cycle_collect,1081 22:32:01 INFO - PROCESS | 23976 | __end_cc_report 22:32:01 INFO - PROCESS | 23976 | __startTimestamp1458797521403__endTimestamp 22:32:01 INFO - PROCESS | 23976 | 22:32:01 INFO - PROCESS | 23976 | ------- Summary: start ------- 22:32:01 INFO - PROCESS | 23976 | Number of tests: 14 22:32:01 INFO - PROCESS | 23976 | 22:32:01 INFO - PROCESS | 23976 | [#0] ai-astar Cycles:10 Average:107.60 Median:109.00 stddev:3.84 (3.5%) stddev-sans-first:4.03 22:32:01 INFO - PROCESS | 23976 | Values: 109.0 109.0 104.0 109.0 111.0 110.0 98.0 109.0 108.0 109.0 22:32:01 INFO - PROCESS | 23976 | 22:32:01 INFO - PROCESS | 23976 | [#1] audio-beat-detection Cycles:10 Average:145.30 Median:154.00 stddev:18.45 (12.0%) stddev-sans-first:19.29 22:32:01 INFO - PROCESS | 23976 | Values: 154.0 132.0 147.0 168.0 125.0 155.0 154.0 124.0 172.0 122.0 22:32:01 INFO - PROCESS | 23976 | 22:32:01 INFO - PROCESS | 23976 | [#2] audio-dft Cycles:10 Average:160.40 Median:160.00 stddev:1.26 (0.8%) stddev-sans-first:1.33 22:32:01 INFO - PROCESS | 23976 | Values: 160.0 160.0 161.0 160.0 160.0 159.0 159.0 163.0 160.0 162.0 22:32:01 INFO - PROCESS | 23976 | 22:32:01 INFO - PROCESS | 23976 | [#3] audio-fft Cycles:10 Average:86.00 Median:73.50 stddev:17.79 (24.2%) stddev-sans-first:18.13 22:32:01 INFO - PROCESS | 23976 | Values: 72.0 76.0 101.0 92.0 71.0 76.0 75.0 122.0 104.0 71.0 22:32:01 INFO - PROCESS | 23976 | 22:32:01 INFO - PROCESS | 23976 | [#4] audio-oscillator Cycles:10 Average:105.30 Median:92.00 stddev:20.77 (22.6%) stddev-sans-first:21.46 22:32:01 INFO - PROCESS | 23976 | Values: 92.0 94.0 138.0 93.0 93.0 92.0 134.0 91.0 92.0 134.0 22:32:01 INFO - PROCESS | 23976 | 22:32:01 INFO - PROCESS | 23976 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.84 (0.7%) stddev-sans-first:0.88 22:32:01 INFO - PROCESS | 23976 | Values: 117.0 116.0 117.0 119.0 118.0 117.0 117.0 118.0 118.0 117.0 22:32:01 INFO - PROCESS | 23976 | 22:32:01 INFO - PROCESS | 23976 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 22:32:01 INFO - PROCESS | 23976 | Values: 145.0 145.0 145.0 145.0 145.0 145.0 146.0 145.0 146.0 145.0 22:32:01 INFO - PROCESS | 23976 | 22:32:01 INFO - PROCESS | 23976 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 22:32:01 INFO - PROCESS | 23976 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 22:32:01 INFO - PROCESS | 23976 | 22:32:01 INFO - PROCESS | 23976 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:55.00 stddev:3.06 (5.6%) stddev-sans-first:3.23 22:32:01 INFO - PROCESS | 23976 | Values: 55.0 54.0 54.0 55.0 56.0 56.0 55.0 64.0 55.0 53.0 22:32:01 INFO - PROCESS | 23976 | 22:32:01 INFO - PROCESS | 23976 | [#9] json-stringify-tinderbox Cycles:10 Average:61.40 Median:61.50 stddev:0.52 (0.8%) stddev-sans-first:0.50 22:32:01 INFO - PROCESS | 23976 | Values: 62.0 62.0 61.0 61.0 61.0 61.0 62.0 61.0 61.0 62.0 22:32:01 INFO - PROCESS | 23976 | 22:32:01 INFO - PROCESS | 23976 | [#10] stanford-crypto-aes Cycles:10 Average:78.20 Median:77.50 stddev:2.78 (3.6%) stddev-sans-first:2.92 22:32:01 INFO - PROCESS | 23976 | Values: 77.0 77.0 78.0 77.0 78.0 78.0 77.0 86.0 77.0 77.0 22:32:01 INFO - PROCESS | 23976 | 22:32:01 INFO - PROCESS | 23976 | [#11] stanford-crypto-ccm Cycles:10 Average:111.30 Median:112.00 stddev:3.37 (3.0%) stddev-sans-first:2.87 22:32:01 INFO - PROCESS | 23976 | Values: 117.0 114.0 110.0 115.0 114.0 108.0 108.0 110.0 108.0 109.0 22:32:01 INFO - PROCESS | 23976 | 22:32:01 INFO - PROCESS | 23976 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.10 Median:141.00 stddev:3.67 (2.6%) stddev-sans-first:3.82 22:32:01 INFO - PROCESS | 23976 | Values: 142.0 142.0 141.0 141.0 140.0 131.0 140.0 145.0 138.0 141.0 22:32:01 INFO - PROCESS | 23976 | 22:32:01 INFO - PROCESS | 23976 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:63.00 stddev:1.17 (1.9%) stddev-sans-first:1.09 22:32:01 INFO - PROCESS | 23976 | Values: 61.0 64.0 64.0 62.0 63.0 64.0 63.0 62.0 62.0 61.0 22:32:01 INFO - PROCESS | 23976 | -------- Summary: end -------- 22:32:01 INFO - PROCESS | 23976 | 22:32:02 INFO - TEST-INFO | 23976: exit 0 22:32:02 INFO - TEST-OK | kraken | took 58819ms 22:32:02 INFO - SUITE-END | took 1168s 22:32:02 INFO - Completed test suite (00:19:28) 22:32:02 INFO - javascript benchmark 22:32:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2988.7310142087213, 3014.924626884329, 3063.295442048329, 3066.3867226554694, 3093.644230913445, 5014.849554513361, 5127.820526281581, 5139.563137133344, 5194.065068287707, 5205.531502164805, 5090.541851233388, 5158.871028224296, 5159.845204643867, 5226.216067589863, 5249.86875328117, 4693.530646935296, 4727.66906316558, 4803.5676789088975, 4830.444498882638, 4854.8300809471675, 4562.589366956973, 4782.0, 4813.157697402958, 4838.685485443435, 4841.951580484185, 4713.5993440557595, 4749.145153872284, 4750.738709370983, 4755.595774359149, 4797.448293446246, 4753.025629745928, 4754.524547545252, 4778.283257511366, 4781.6891902026255, 4803.447603525605, 4602.125596136723, 4691.953080469186, 4745.976270118627, 4749.0, 4796.400449943757, 5134.717590532519, 5160.071187186305, 5163.277141200235, 5185.585153187773, 5185.922211166836, 5530.087535556629, 5557.5553955683445, 5563.054280772238, 5567.359753628344, 5611.13027480737, 5400.135978243501, 5455.099908515091, 5535.169724541311, 5552.888942221133, 5570.220169176318, 5146.794128234867, 5196.636235463481, 5203.895922081575, 5211.03595834768, 5211.739413029333, 5645.633033852787, 5662.631928924607, 5669.262995810518, 5670.489655930986, 5676.602637815396, 5308.761105750251, 5420.593455490854, 5439.809606663748, 5484.424135465719, 5516.089845175581, 5481.671099733949, 5493.7802487900035, 5494.038543254915, 5494.2857428534835, 5499.450054994549, 5369.0, 5473.8357849264585, 5476.342838859362, 5484.067708489566, 5521.0, 5495.807646732345, 5549.334079910436, 5555.77776888928, 5580.358258800209, 5598.2442370280305, 4073.7555746655294, 4074.0425999890003, 4089.9182016359505, 4113.856015039519, 4116.650084742771, 3682.668559829628, 3744.85020599173, 3782.924341513154, 3788.6969042476535, 3800.5439347278502, 5129.0, 5148.665336753099, 5151.459096794858, 5162.793488260502, 5201.193814958688, 5414.07960646691, 5463.4263402342185, 5463.535599474089, 5470.56235501159, 5522.061249587579, 5036.748162591855, 5161.716105614152, 5178.844634660966, 5246.842594722164, 5282.260483532308, 4635.2120139576355, 4641.628669706415, 4646.140464014168, 4655.604273636779, 4725.0, 5741.397153298927, 5751.769929202868, 5754.223179870663, 5754.568407369464, 5755.65466072037, 5366.543843773323, 5548.4451554845, 5561.610687251854, 5646.3506696728755, 5660.009498337692, 5696.829095127153, 5722.971385143048, 5727.7422515986045, 5730.684812335361, 5740.913886291625, 5433.212184233343, 5437.945620543744, 5439.619226654097, 5442.755076021668, 5446.373667028184, 5337.199420087018, 5514.558835293086, 5585.078462053716, 5602.1036634138345, 5638.407967163553, 5402.054640437987, 5415.4313797050745, 5415.756290966995, 5416.7020813855615, 5418.674879507243, 5267.420583735862, 5368.785248590013, 5372.221027951004, 5378.462153784747, 5421.0, 5252.395974462986, 5256.0, 5288.3918349390315, 5290.735463226746, 5341.626086174086, 5401.810936617199, 5409.648372855751, 5430.185472179047, 5442.619016668954, 5444.26502422168, 5178.119719647593, 5231.450697676842, 5310.097283461898, 5331.680099194061, 5380.596455265949], "unit": "score", "name": "dojo.html", "value": 5091.555843815974}, {"lowerIsBetter": false, "replicates": [560.0646919644194, 584.1500616602841, 586.2964442668797, 600.1897438458083, 624.9625022498648, 29701.702982970164, 38690.0, 39000.609993900056, 39344.99999999996, 39362.40956385649, 41263.79368103163, 41370.0, 41601.58398416015, 41741.79129104358, 41762.58237417625, 7359.3744531714865, 8529.402941794076, 8704.912950870505, 8710.738677839643, 10084.445355505444, 10140.746481337988, 10308.433036183007, 10308.948455257712, 10311.0, 10316.277860549764, 10284.794304113913, 10316.948415257913, 10368.170546356274, 10389.584416623364, 10417.531211095518, 7418.925810741905, 10271.383716976969, 10477.528511217013, 10739.946300268526, 10743.19426043042, 10182.796344073151, 10291.331063480924, 10301.175905927508, 10312.381257124596, 10320.329178603366, 38071.0, 38130.0, 38533.229335413416, 38573.80713096417, 38647.806760966014, 3276.5576647152807, 3366.7306615470948, 3400.591928968515, 3459.8616055357757, 3549.94675079874, 31952.840235798903, 32139.0, 32415.6758432415, 32469.0, 32711.509327359872, 4081.7346872453195, 4195.937060944088, 4216.7259128156575, 4225.260579398624, 4240.173166232586, 317145.0, 318239.0, 318406.0, 318699.0, 318794.0, 59954.10068848971, 60019.899303524166, 60436.395636043955, 60480.09279860806, 60536.09195862066, 63908.680456597416, 64003.0, 64308.35691643117, 64339.0, 64371.678141608994, 15404.61488462775, 15411.691766164615, 15417.0, 15417.229138543027, 15417.922910385601, 11767.058635309155, 11785.764284714258, 11811.232269902428, 11811.822822657667, 11818.113641476752, 19394.806051939584, 19908.203671853254, 19931.20275189005, 19946.70079948802, 20004.399868003984, 6581.736730530821, 7998.5600791957, 8116.080444504188, 8189.099199088096, 8312.0, 1146.9276226728036, 1159.252282277926, 1178.6522975722182, 1196.3061424373843, 1265.3167289663663, 32560.511592326133, 32576.02271931846, 32724.836375818446, 32738.672613273564, 33312.3337533248, 1136.0968030415838, 1195.5576436718295, 1201.2818981647422, 1216.2702378572963, 1245.875412458765, 16921.238544265536, 16929.576760580836, 16932.830671693126, 16959.15204239783, 16959.576010599587, 373976.0, 377051.0, 378440.0, 378777.0, 380111.0, 56238.813730489615, 56561.434385655615, 56764.0, 57055.14417283744, 57077.429225708045, 1088.6353071721062, 1326.635175326793, 1416.6954104867502, 1419.0775995602735, 1428.649980754701, 28075.805975894524, 29963.700362996093, 30220.546691800082, 30581.694183058775, 30766.538501922936, 41191.0, 41439.7928010358, 41637.37543936904, 41669.374959375025, 41701.37447938344, 191934.0, 192300.0, 192699.0, 192801.0, 193026.0, 30365.392692146474, 32196.517052243766, 35923.46114808332, 35946.8202658985, 35987.820060899525, 40493.1901361977, 41412.585874140874, 41532.58467415408, 41961.16077678368, 42048.789756051025, 35049.474257886664, 35092.64907350996, 35099.0, 35354.0, 35667.46498802572, 35439.46840797442, 35558.46662300016, 35675.28649427049, 35817.82091089632, 36001.81999089988, 38761.4185787219, 38808.80595597004, 38967.415488767125, 39086.4137037939, 39574.0, 33575.83212084022, 34713.0, 34731.82634086914, 34812.477812833335, 34996.300073998886, 26923.461530768884, 27099.86450067737, 27271.909123635625, 27300.0, 27614.0], "unit": "score", "name": "ext.html", "value": 19298.03630882784}, {"lowerIsBetter": false, "replicates": [348.97401639180805, 358.5500197252448, 358.7237826873307, 363.88355726167623, 366.46313151233454, 17705.291788328468, 17728.0, 19137.138828752704, 19156.329528466507, 19203.519912002208, 17774.0, 18443.72334414985, 19151.329703460382, 19155.61688766224, 19186.520336991583, 5465.699386533739, 5596.608237423362, 5634.605577609569, 5634.830955071334, 5635.408282130379, 3979.9403008954887, 5506.697131657757, 5853.76584936602, 6075.878482430348, 6104.877902441948, 6013.849653758669, 6056.121862329959, 6067.393260673942, 6067.453929146376, 6080.179175811253, 5918.615290006157, 5977.133315669225, 6041.667708276043, 6049.364816694272, 6054.364291749369, 3624.27514497099, 5170.25031370453, 5292.761825717814, 5337.199420086979, 5340.332458442695, 20412.693809592718, 20598.0, 20749.377518674464, 22219.22232721863, 22225.0, 2315.2822624986306, 2349.3186975777003, 2501.337145656384, 2514.8742562871785, 2794.23158631378, 13614.93192534031, 14018.369173387222, 14034.298285085704, 14133.081349712236, 14469.638259043502, 1979.544704717923, 2017.1326329678232, 2025.5341271507489, 2034.4506983114477, 2111.5671287386203, 68664.6566767168, 71555.0, 71938.64030679865, 72286.63856680735, 72380.27619723788, 10288.537015834156, 10364.378137311785, 10468.110210632181, 10588.470576471145, 10700.946495267473, 13245.602631921058, 13380.598582042554, 13472.730545389037, 13492.325383730971, 13510.189388636516, 8205.261526462647, 8411.789705257295, 8422.452540584842, 8527.65889364431, 8573.056963733985, 8538.103499132625, 8554.05905350411, 8568.271696905707, 8668.349873759493, 8671.479711217347, 6493.220813502316, 6572.375624315682, 6626.0, 6645.900311495331, 6693.096431981718, 1652.107861754639, 1715.9742603860952, 1754.6052138268788, 1778.0527229550378, 1790.64187162568, 944.6268723854039, 992.7021893431942, 1049.0768124050787, 1098.9010989011028, 1116.771061932302, 17936.730949035777, 17962.91018544925, 17964.820351796316, 18074.819251807578, 18436.0, 1021.4535223655308, 1055.266589720137, 1068.631322193842, 1074.0977578833817, 1094.9835752463719, 10592.417417042137, 10700.78598428027, 11035.282706624044, 11098.371477780966, 11248.606298779503, 474698.0, 495494.0, 502375.0, 503442.0, 511340.0, 86339.56830215809, 86628.56685716531, 86898.69651955226, 87676.56161719278, 87844.5607771957, 1081.5403453532217, 1165.7668466306773, 1192.1476144556684, 1193.1945936492832, 1198.6763573835017, 16870.915645421694, 16988.74516882223, 17138.828611713725, 17172.141392930054, 17174.141292935554, 38211.80894095512, 38533.0, 39679.60320396759, 40336.59663403328, 40483.59516404916, 55484.16773748316, 55549.0, 55572.0, 55837.0, 55999.0, 7776.572288524186, 8127.593620318842, 8154.836903261783, 8233.83532329362, 8317.251447369767, 12849.614511564669, 12975.545855894998, 12980.286084265455, 13256.0, 13364.665883352995, 11393.54425822991, 11519.76960460803, 11530.192886497865, 11691.649250522498, 11746.530138794353, 10761.515731792244, 11434.19960602783, 11569.6529104127, 11656.273247889307, 11666.300021998708, 11266.605668801552, 11909.702257443632, 11965.102617303563, 12038.097142714156, 12058.276503409823, 8156.143604921398, 8161.224683655043, 8184.345252379676, 8207.589620518831, 8286.337093032422, 8555.657773688983, 11318.773624527628, 11577.421128943352, 11684.415779210836, 11864.76270474603], "unit": "score", "name": "jquery.html", "value": 9225.707634780503}, {"lowerIsBetter": false, "replicates": [1224.3266203588034, 1446.8914831387644, 1450.129922046772, 1625.886187966842, 1820.918058687359, 7371.115466144063, 7844.686212551498, 7847.25451082147, 7850.0579930408285, 7854.214578542143, 7592.240775922405, 7763.301302882739, 7763.340116090139, 7763.495372800764, 7764.378849692025, 1783.8929664220123, 1828.9176987035548, 2151.4406254373857, 2167.729033870766, 2183.366823621148, 2039.7144399784042, 2043.9284625038126, 2049.333966460899, 2049.80526849949, 2050.1389416445054, 2148.742150941889, 2159.147136880939, 2160.82713382929, 2169.078141789741, 2222.344408399526, 2181.7709140540333, 2208.977910220893, 2215.4018415028013, 2217.2350539064078, 2218.4121207879925, 2205.7022301989186, 2219.6448568229007, 2223.2774348336693, 2225.6105181593157, 2231.854929429598, 7891.0, 7930.206979302081, 7951.244631759973, 7957.084935232465, 7962.960185199037, 4546.158960592301, 4645.349651048856, 4651.930221046653, 4652.860414187579, 4654.837080702193, 3081.984590077058, 3159.462891308483, 3285.901422957315, 3288.8355582221034, 3299.026787097812, 960.8750862387915, 984.1782111936542, 1007.4811472091878, 1014.5282443663732, 1023.8515415264745, 10901.0, 10918.727031824188, 10922.836157457645, 10927.453627318602, 10929.672109836718, 4120.587941205856, 4160.583941605815, 4194.790260486963, 4244.533101358848, 4256.553061928515, 9350.812983740423, 9362.25101991839, 9372.484513351832, 9373.765655858659, 9378.062193780568, 4791.688540244873, 4809.735464549413, 4809.78355973982, 4832.0, 4839.564439200489, 3815.8855234343014, 4322.891927701769, 4400.977995110004, 4442.111577684476, 4485.910281794346, 3615.475756015363, 3676.0, 3698.0, 3723.832427540767, 3723.9255214896093, 1130.2427373659668, 1137.6928229378022, 1138.3283862521153, 1143.6454699043156, 1143.782681290552, 1131.4286285425972, 1139.943002849854, 1141.08713029576, 1330.6806366471976, 1400.4958215042577, 7563.130240022468, 7613.42899282556, 7654.923450765533, 7702.460827742117, 7704.075510938611, 396.6331143692131, 401.90354314964196, 403.4996604210816, 406.8413318805668, 409.3123552431943, 5942.078977758368, 5979.730912108966, 5981.162637230791, 6000.909986350208, 6032.849178770566, 9323.20752736025, 9579.13787759105, 9787.070228328297, 9857.0, 9898.950505247427, 9664.613415463444, 9723.367981081206, 9760.56077476501, 9762.414255144715, 9768.36505627132, 7265.927340726631, 7440.813979650552, 7469.962650186714, 7479.102507699002, 7534.773956781305, 7456.888146677696, 7485.625718714152, 7519.1728909818785, 7549.547027178387, 7551.169371369255, 8398.790030249293, 8480.787980300542, 8590.1839325264, 8741.475511469333, 8744.081871403665, 8762.430442021248, 8804.735857924272, 8905.421147625642, 9002.0, 9061.09389061115, 5604.971975140098, 6639.170103737033, 6792.830179245559, 6930.653467326512, 7025.789226323219, 7113.039739635083, 7160.964195178991, 7168.569885806868, 7193.136823581203, 7206.639668016683, 6637.103990961352, 6849.1438570178725, 6896.586204827727, 6934.271901450476, 7044.471664625071, 6455.3221911700475, 6483.805485835433, 6495.935040649533, 6550.6069635822005, 6576.8355791105605, 7006.859862802614, 7071.893921591078, 7081.00865878767, 7140.428765698628, 7146.857062858609, 6523.64119973406, 6561.343865613591, 6568.113304703995, 6606.6366349849295, 6608.240052393844, 6778.3221677831825, 6843.828904277433, 6860.6912688930115, 6861.862762744618, 6863.725450981905], "unit": "score", "name": "mootools.html", "value": 4364.96635488681}, {"lowerIsBetter": false, "replicates": [322.45827010622145, 325.53123502156905, 329.755980574375, 332.55935884952436, 333.2734638488096, 6074.483668888139, 6118.755249790009, 6120.755169793214, 6151.815445536636, 6156.784512542062, 5994.310654274749, 6034.094885767137, 6034.97405441075, 6048.334683184846, 6049.0, 4372.803223854934, 4516.954830451687, 4589.403377560912, 4593.356930029799, 4640.164770341337, 4592.425946756655, 4600.608948239404, 4618.653600979923, 4621.191291523986, 4637.860864174063, 4576.610988066019, 4590.724556526602, 4599.632029437637, 4602.9769851150695, 4613.8154473821005, 4301.26878430666, 4508.368828364031, 4592.058627981256, 4599.770011499445, 4625.444946606429, 4014.0, 4017.31705610047, 4022.7184097113213, 4023.396490526415, 4031.778252196128, 5806.65160090396, 5808.157817116495, 5809.419058094157, 5829.883402331972, 5830.62100963436, 5318.468153184689, 5325.733713314319, 5333.280007199056, 5333.679979201261, 5347.893042139174, 6366.840828979266, 6367.6497792621385, 6370.108184854124, 6374.0, 6379.489640828769, 4185.91628167438, 4273.081287523198, 4282.743035417854, 4312.762798046107, 4459.397981272519, 6606.273309935903, 6689.23073846509, 6722.563033402862, 6751.763688270936, 6761.661916904135, 4397.84607538741, 4432.180046691373, 4441.68908176431, 4444.3333499974615, 4449.7997590108525, 4494.37078808967, 4495.303227999665, 4496.752678602643, 4497.370368148462, 4497.965467942392, 5252.789888404497, 5259.868503287448, 5261.631685781958, 5266.710330931835, 5270.156774916071, 6196.628202307876, 6399.840003999937, 6458.451031662361, 6462.127612772216, 6463.7091330890225, 1607.477569789823, 1616.8302328255363, 1625.268629116902, 1625.5367220342146, 1631.5676345768381, 974.9025097490194, 1057.259918057363, 1069.8448724934997, 1077.6389909380446, 1086.190787863047, 6117.0, 6134.601250918676, 6182.1345011698395, 6201.81394558164, 6215.440610345091, 6595.307492713196, 6600.669966501656, 6604.405603495708, 6613.0, 6618.569792963442, 6186.659733714689, 6188.845278868064, 6191.81424557264, 6194.690265486708, 6198.659073750897, 3527.8412471438332, 3557.964420355815, 3565.5186549815962, 3566.7681600695873, 3573.874914377984, 6685.164354455693, 6828.760993365208, 6846.7945961621235, 6860.279670634612, 6874.518783685194, 6708.6310252936555, 6749.358810912955, 6750.5274630775375, 6752.696128674123, 6756.797296081126, 6815.079964204868, 6834.589924604539, 6835.487338449537, 6836.213835408892, 6840.794776156723, 6573.80278591643, 6578.76974305897, 6580.177477815273, 6581.045748366556, 6584.308647591934, 6292.9370706294185, 6499.837504062436, 6503.122078519528, 6513.023046542867, 6514.413702766774, 6765.42493888025, 6813.080234168324, 6823.249442561413, 6836.453083753188, 6836.692348844214, 4550.294704320836, 4551.453825540824, 4556.134334476439, 4556.521565235603, 4560.794764235551, 6548.541602087998, 6565.212174539086, 6570.868582628416, 6571.211454625284, 6571.638559879252, 6329.177206963065, 6407.71165297572, 6412.326705695835, 6416.422521973045, 6419.325970773001, 6416.422521973045, 6493.415592596689, 6494.7077381517, 6501.057346684799, 6504.1869766279215, 6336.58812177207, 6349.777757778455, 6353.269374022047, 6361.077643741724, 6361.14124593174, 6497.837554061186, 6533.477321814148, 6541.672916354068, 6548.279689234085, 6548.508861835287, 5979.581429300081, 6103.359147289649, 6373.553851230369, 6377.489800816016, 6379.649119298483], "unit": "score", "name": "prototype.html", "value": 4812.207544258829}, {"lowerIsBetter": false, "replicates": [745.8321877577546, 764.3083009876065, 770.4529783853463, 778.6807408962324, 785.5012067337241, 13478.865211347884, 13718.108322959013, 13719.931400342997, 13723.725525489484, 13750.106243094191, 12120.454579543919, 12649.17780344277, 12679.4928202872, 12696.301703406309, 12707.682307942307, 830.6345208108443, 839.2656425627575, 840.6553313141613, 840.794005468661, 841.154639587214, 854.1543871567166, 854.2738672128672, 860.3375400941271, 860.7202659135775, 860.9827803443927, 885.2475395913455, 889.1330952321499, 889.7642124836923, 889.8264838356523, 890.0387581412092, 879.5118709116438, 884.5754038061734, 885.968991085309, 886.0342226972599, 887.041994645781, 645.3191882563893, 646.805958212539, 648.3937518420292, 648.5460177875506, 648.7275344355382, 12379.690507737288, 12409.689757756038, 12425.502979880885, 12433.0, 12474.064445166558, 9990.45052522111, 10374.481275936248, 10502.054815066604, 10560.841587376195, 10598.78802423955, 9870.45712485813, 9909.603615855358, 10012.899871001342, 10078.143357814595, 10365.689029329133, 3656.323580137683, 3667.229881724841, 3673.3571624965525, 3695.3902606069964, 3750.043738846604, 44796.552034479566, 48658.51341486611, 48696.269555956686, 48769.0, 48811.26783098292, 10302.845457318146, 10374.481275936172, 10441.530131144116, 10567.89432105669, 10624.734381640366, 16481.505554833373, 16523.586910327336, 16525.91737041331, 16535.66928661444, 16554.58613534671, 7726.845463090706, 7771.339436147878, 8195.754127376189, 8277.255047045795, 8278.379121565908, 4508.706934049276, 4610.976945115253, 4624.491305956342, 4665.743384113838, 4809.9038019240115, 3119.5788568542957, 3153.668864769212, 3164.193130751644, 3194.1535493094348, 3205.6634053424523, 615.230961298377, 629.7197747002632, 631.4601016131234, 631.8641492079225, 632.2128949457863, 620.8044465993198, 645.4642646603309, 651.491836367634, 662.5593980003243, 666.919590263766, 8270.586470676442, 8550.102239264788, 8652.134786521297, 8660.30717542595, 8945.46327220369, 599.9520038396918, 604.5828378418964, 618.2797041446754, 726.8800647893038, 748.7042618165794, 4112.177564487055, 4142.689298302639, 4188.6230239278, 4212.662986961036, 4228.746275223435, 59495.40504594899, 60205.39794601998, 60416.0, 60686.39313606896, 60900.69549652223, 50407.49592504101, 52986.47013529892, 53042.20436693453, 53350.73324633352, 53498.732506338, 41593.37609935853, 48732.26901596408, 48872.5112748875, 49355.75322123367, 50348.244776328385, 8581.570921453778, 8853.468791872509, 9077.044595353223, 9118.544072796201, 9253.306002049738, 36738.63261367352, 36941.44587831131, 37816.62183378131, 37973.0, 38068.80965595154, 42859.928501787705, 43103.35344969765, 48365.0, 48550.271745923135, 49572.50427495679, 11662.0, 11775.882241177822, 11830.585929492427, 11855.940720296689, 12204.0, 11952.70118247016, 12325.506979721069, 12390.256584604953, 13011.21932684004, 13086.607401777961, 11291.548338066714, 11440.48517816717, 11621.709457263636, 11771.764564708486, 11965.820512692491, 11782.646520604396, 11876.704882634149, 11894.821577676168, 12033.939830300793, 12195.878041219474, 11651.41742912834, 11737.35444550558, 11837.467313971065, 12184.20802647825, 12245.816312755494, 10016.59933602677, 10199.34082515976, 10253.538590763583, 10298.3820970739, 10382.377057376581, 10209.591616335263, 10243.436610986468, 10281.12610428122, 10332.896671033193, 10333.379997200193], "unit": "score", "name": "yui.html", "value": 6447.3992348245465}], "name": "dromaeo_css", "value": 7049.948007940189}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 109.0, 104.0, 109.0, 111.0, 110.0, 98.0, 109.0, 108.0, 109.0], "unit": "score", "name": "ai-astar", "value": 107.6}, {"lowerIsBetter": true, "replicates": [154.0, 132.0, 147.0, 168.0, 125.0, 155.0, 154.0, 124.0, 172.0, 122.0], "unit": "score", "name": "audio-beat-detection", "value": 145.3}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 161.0, 160.0, 160.0, 159.0, 159.0, 163.0, 160.0, 162.0], "unit": "score", "name": "audio-dft", "value": 160.4}, {"lowerIsBetter": true, "replicates": [72.0, 76.0, 101.0, 92.0, 71.0, 76.0, 75.0, 122.0, 104.0, 71.0], "unit": "score", "name": "audio-fft", "value": 86.0}, {"lowerIsBetter": true, "replicates": [92.0, 94.0, 138.0, 93.0, 93.0, 92.0, 134.0, 91.0, 92.0, 134.0], "unit": "score", "name": "audio-oscillator", "value": 105.3}, {"lowerIsBetter": true, "replicates": [117.0, 116.0, 117.0, 119.0, 118.0, 117.0, 117.0, 118.0, 118.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.4}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.2}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [55.0, 54.0, 54.0, 55.0, 56.0, 56.0, 55.0, 64.0, 55.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.7}, {"lowerIsBetter": true, "replicates": [62.0, 62.0, 61.0, 61.0, 61.0, 61.0, 62.0, 61.0, 61.0, 62.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 61.4}, {"lowerIsBetter": true, "replicates": [77.0, 77.0, 78.0, 77.0, 78.0, 78.0, 77.0, 86.0, 77.0, 77.0], "unit": "score", "name": "stanford-crypto-aes", "value": 78.2}, {"lowerIsBetter": true, "replicates": [117.0, 114.0, 110.0, 115.0, 114.0, 108.0, 108.0, 110.0, 108.0, 109.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 111.3}, {"lowerIsBetter": true, "replicates": [142.0, 142.0, 141.0, 141.0, 140.0, 131.0, 140.0, 145.0, 138.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.1}, {"lowerIsBetter": true, "replicates": [61.0, 64.0, 64.0, 62.0, 63.0, 64.0, 63.0, 62.0, 62.0, 61.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 62.6}], "name": "kraken", "value": 1471.6}]} 22:32:02 INFO - Return code: 0 22:32:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 22:32:02 ERROR - # TBPL SUCCESS # 22:32:02 INFO - Running post-action listener: _resource_record_post_action 22:32:02 INFO - Running post-run listener: _resource_record_post_run 22:32:03 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 528277504; Read time: 0; Write time: 474108 22:32:03 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 243011584; Read time: 0; Write time: 282512 22:32:03 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 0; Write bytes: 285265920; Read time: 0; Write time: 191596 22:32:03 INFO - Running post-run listener: _upload_blobber_files 22:32:03 INFO - Blob upload gear active. 22:32:03 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 22:32:03 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 22:32:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 22:32:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 22:32:04 INFO - (blobuploader) - INFO - Open directory for files ... 22:32:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 22:32:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:32:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:32:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:32:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:32:05 INFO - (blobuploader) - INFO - Done attempting. 22:32:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:32:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:32:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:32:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:32:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:32:07 INFO - (blobuploader) - INFO - Done attempting. 22:32:07 INFO - (blobuploader) - INFO - Iteration through files over. 22:32:07 INFO - Return code: 0 22:32:07 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 22:32:07 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 22:32:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/29deb568e4c94747e791a765a4e94ce60e408a51e1ff4e14ad9a8daf2b6a74b2afa1042db1fb34477cd301aef363c768f7b9d9ab844c3a68088b55362ffb6948", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/714be085d681f98d750f8419599f0558c99101bda114254d1a4d0bc4d2c6379808a5a8a7154db290c6515dacb883677670de4e5347ff5befce3e11211c320146"} 22:32:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 22:32:07 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 22:32:07 INFO - Contents: 22:32:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/29deb568e4c94747e791a765a4e94ce60e408a51e1ff4e14ad9a8daf2b6a74b2afa1042db1fb34477cd301aef363c768f7b9d9ab844c3a68088b55362ffb6948", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/714be085d681f98d750f8419599f0558c99101bda114254d1a4d0bc4d2c6379808a5a8a7154db290c6515dacb883677670de4e5347ff5befce3e11211c320146"} 22:32:07 INFO - Running post-run listener: copy_logs_to_upload_dir 22:32:07 INFO - Copying logs to upload dir... 22:32:07 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 22:32:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.912362 ========= master_lag: 3.66 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-03-23 22:32:10.754389) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-23 22:32:10.757657) ========= 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=4ac8d263c7293b36a1be1aed000001be-1458787044.235786-1166472986 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/29deb568e4c94747e791a765a4e94ce60e408a51e1ff4e14ad9a8daf2b6a74b2afa1042db1fb34477cd301aef363c768f7b9d9ab844c3a68088b55362ffb6948", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/714be085d681f98d750f8419599f0558c99101bda114254d1a4d0bc4d2c6379808a5a8a7154db290c6515dacb883677670de4e5347ff5befce3e11211c320146"} build_url:https://queue.taskcluster.net/v1/task/DC7IPQZhRDeCkRNshbNrbA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011237 build_url: 'https://queue.taskcluster.net/v1/task/DC7IPQZhRDeCkRNshbNrbA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/29deb568e4c94747e791a765a4e94ce60e408a51e1ff4e14ad9a8daf2b6a74b2afa1042db1fb34477cd301aef363c768f7b9d9ab844c3a68088b55362ffb6948", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/714be085d681f98d750f8419599f0558c99101bda114254d1a4d0bc4d2c6379808a5a8a7154db290c6515dacb883677670de4e5347ff5befce3e11211c320146"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-23 22:32:10.782670) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 22:32:10.783025) ========= 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=4ac8d263c7293b36a1be1aed000001be-1458787044.235786-1166472986 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004580 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 22:32:10.834578) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-23 22:32:10.834917) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-23 22:32:10.835255) ========= ========= Total master_lag: 3.91 =========