builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-017 starttime: 1457276039.26 results: success (0) buildid: 20160306043006 builduid: d782376e5a82444ead1dbff0263a290a revision: b972f49b8c7e563c3a50126e5647bd40d1c3b37c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-06 06:53:59.257822) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-06 06:53:59.258260) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-06 06:53:59.258637) ========= 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=0333a256a5e4f052382dd180000001b1-1457273634.917430-1353739975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006386 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.07 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-06 06:53:59.331467) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-06 06:53:59.331734) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-06 06:53:59.380065) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 06:53:59.380323) ========= 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=0333a256a5e4f052382dd180000001b1-1457273634.917430-1353739975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004554 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 06:53:59.433822) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-06 06:53:59.434104) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-06 06:53:59.434418) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 06:53:59.434679) ========= 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=0333a256a5e4f052382dd180000001b1-1457273634.917430-1353739975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-06 06:53:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-03-06 06:54:00 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.399617 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 06:53:59.849023) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 06:53:59.849350) ========= 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=0333a256a5e4f052382dd180000001b1-1457273634.917430-1353739975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015486 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 06:53:59.898795) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 06:53:59.899151) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev b972f49b8c7e563c3a50126e5647bd40d1c3b37c --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 b972f49b8c7e563c3a50126e5647bd40d1c3b37c --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=0333a256a5e4f052382dd180000001b1-1457273634.917430-1353739975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-06 06:54:00,186 truncating revision to first 12 chars 2016-03-06 06:54:00,187 Setting DEBUG logging. 2016-03-06 06:54:00,187 attempt 1/10 2016-03-06 06:54:00,187 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/b972f49b8c7e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-06 06:54:00,460 unpacking tar archive at: mozilla-inbound-b972f49b8c7e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.587161 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 06:54:00.499087) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-06 06:54:00.499413) ========= echo b972f49b8c7e563c3a50126e5647bd40d1c3b37c in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'b972f49b8c7e563c3a50126e5647bd40d1c3b37c'] 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=0333a256a5e4f052382dd180000001b1-1457273634.917430-1353739975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False b972f49b8c7e563c3a50126e5647bd40d1c3b37c program finished with exit code 0 elapsedTime=0.004658 script_repo_revision: 'b972f49b8c7e563c3a50126e5647bd40d1c3b37c' ========= master_lag: 0.08 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-06 06:54:00.584429) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-06 06:54:00.584722) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-06 06:54:00.594283) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-03-06 06:54:00.594552) ========= /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=0333a256a5e4f052382dd180000001b1-1457273634.917430-1353739975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:54:00 INFO - MultiFileLogger online at 20160306 06:54:00 in /builds/slave/test-pgo 06:54:00 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 06:54:00 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 06:54:00 INFO - {'append_to_log': False, 06:54:00 INFO - 'base_work_dir': '/builds/slave/test-pgo', 06:54:00 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 06:54:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 06:54:00 INFO - 'branch': 'Mozilla-Inbound', 06:54:00 INFO - 'buildbot_json_path': 'buildprops.json', 06:54:00 INFO - 'config_files': ('talos/linux_config.py',), 06:54:00 INFO - 'default_actions': ('clobber', 06:54:00 INFO - 'read-buildbot-config', 06:54:00 INFO - 'download-and-extract', 06:54:00 INFO - 'populate-webroot', 06:54:00 INFO - 'create-virtualenv', 06:54:00 INFO - 'install', 06:54:00 INFO - 'run-tests'), 06:54:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:54:00 INFO - 'download_minidump_stackwalk': True, 06:54:00 INFO - 'download_symbols': 'ondemand', 06:54:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:54:00 INFO - 'tooltool.py': '/tools/tooltool.py', 06:54:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:54:00 INFO - '/tools/misc-python/virtualenv.py')}, 06:54:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:54:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:54:00 INFO - 'installer_path': 'installer.exe', 06:54:00 INFO - 'log_level': 'info', 06:54:00 INFO - 'log_name': 'talos', 06:54:00 INFO - 'log_to_console': True, 06:54:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:54:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:54:00 INFO - 'opt_config_files': (), 06:54:00 INFO - 'pip_index': False, 06:54:00 INFO - 'sps_profile': False, 06:54:00 INFO - 'sps_profile_interval': 0, 06:54:00 INFO - 'suite': 'dromaeojs', 06:54:00 INFO - 'system_bits': '32', 06:54:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:54:00 INFO - 'title': 'talos-linux64-ix-017', 06:54:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:54:00 INFO - 'use_talos_json': True, 06:54:00 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 06:54:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:54:00 INFO - 'work_dir': 'build'} 06:54:00 INFO - ##### 06:54:00 INFO - ##### Running clobber step. 06:54:00 INFO - ##### 06:54:00 INFO - Running pre-action listener: _resource_record_pre_action 06:54:00 INFO - Running main action method: clobber 06:54:00 INFO - rmtree: /builds/slave/test-pgo/build 06:54:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 06:54:01 INFO - Running post-action listener: _resource_record_post_action 06:54:01 INFO - ##### 06:54:01 INFO - ##### Running read-buildbot-config step. 06:54:01 INFO - ##### 06:54:01 INFO - Running pre-action listener: _resource_record_pre_action 06:54:01 INFO - Running main action method: read_buildbot_config 06:54:01 INFO - Using buildbot properties: 06:54:01 INFO - { 06:54:01 INFO - "project": "", 06:54:01 INFO - "product": "firefox", 06:54:01 INFO - "script_repo_revision": "production", 06:54:01 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 06:54:01 INFO - "repository": "", 06:54:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 06:54:01 INFO - "buildid": "20160306043006", 06:54:01 INFO - "pgo_build": "True", 06:54:01 INFO - "basedir": "/builds/slave/test-pgo", 06:54:01 INFO - "buildnumber": 764, 06:54:01 INFO - "slavename": "talos-linux64-ix-017", 06:54:01 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:54:01 INFO - "platform": "ubuntu64_hw", 06:54:01 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 06:54:01 INFO - "branch": "mozilla-inbound", 06:54:01 INFO - "repo_path": "integration/mozilla-inbound", 06:54:01 INFO - "revision": "b972f49b8c7e563c3a50126e5647bd40d1c3b37c", 06:54:01 INFO - "stage_platform": "linux64-pgo", 06:54:01 INFO - "builduid": "d782376e5a82444ead1dbff0263a290a", 06:54:01 INFO - "slavebuilddir": "test" 06:54:01 INFO - } 06:54:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/B8rXrdc_TV-X2rzihdjt2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 06:54:01 INFO - Running post-action listener: _resource_record_post_action 06:54:01 INFO - ##### 06:54:01 INFO - ##### Running download-and-extract step. 06:54:01 INFO - ##### 06:54:01 INFO - Running pre-action listener: _resource_record_pre_action 06:54:01 INFO - Running main action method: download_and_extract 06:54:01 INFO - mkdir: /builds/slave/test-pgo/build/tests 06:54:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:01 INFO - https://queue.taskcluster.net/v1/task/B8rXrdc_TV-X2rzihdjt2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:54:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B8rXrdc_TV-X2rzihdjt2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 06:54:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B8rXrdc_TV-X2rzihdjt2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 06:54:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B8rXrdc_TV-X2rzihdjt2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 06:54:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B8rXrdc_TV-X2rzihdjt2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:54:04 INFO - Downloaded 1448 bytes. 06:54:04 INFO - Reading from file /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 06:54:04 INFO - Using the following test package requirements: 06:54:04 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 06:54:04 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 06:54:04 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:54:04 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 06:54:04 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:54:04 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 06:54:04 INFO - u'jsshell-linux-x86_64.zip'], 06:54:04 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 06:54:04 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:54:04 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 06:54:04 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 06:54:04 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:54:04 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 06:54:04 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:54:04 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 06:54:04 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:54:04 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 06:54:04 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 06:54:04 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:54:04 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:54:04 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')]} 06:54:04 INFO - https://queue.taskcluster.net/v1/task/B8rXrdc_TV-X2rzihdjt2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:54:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B8rXrdc_TV-X2rzihdjt2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 06:54:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B8rXrdc_TV-X2rzihdjt2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 06:54:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B8rXrdc_TV-X2rzihdjt2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 06:54:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B8rXrdc_TV-X2rzihdjt2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:54:15 INFO - Downloaded 23405326 bytes. 06:54:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 06:54:15 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 06:54:16 INFO - Return code: 0 06:54:16 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:54:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:16 INFO - https://queue.taskcluster.net/v1/task/B8rXrdc_TV-X2rzihdjt2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:54:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B8rXrdc_TV-X2rzihdjt2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 06:54:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B8rXrdc_TV-X2rzihdjt2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 06:54:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B8rXrdc_TV-X2rzihdjt2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 06:54:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B8rXrdc_TV-X2rzihdjt2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:54:17 INFO - Downloaded 23405326 bytes. 06:54:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 06:54:17 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 06:54:19 INFO - Return code: 0 06:54:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:19 INFO - https://queue.taskcluster.net/v1/task/B8rXrdc_TV-X2rzihdjt2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:54:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B8rXrdc_TV-X2rzihdjt2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 06:54:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B8rXrdc_TV-X2rzihdjt2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 06:54:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B8rXrdc_TV-X2rzihdjt2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 06:54:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B8rXrdc_TV-X2rzihdjt2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:54:20 INFO - Downloaded 10845161 bytes. 06:54:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 06:54:20 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 06:54:20 INFO - Return code: 0 06:54:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:20 INFO - https://queue.taskcluster.net/v1/task/B8rXrdc_TV-X2rzihdjt2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:54:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B8rXrdc_TV-X2rzihdjt2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 06:54:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B8rXrdc_TV-X2rzihdjt2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 06:54:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B8rXrdc_TV-X2rzihdjt2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 06:54:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B8rXrdc_TV-X2rzihdjt2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:54:21 INFO - Downloaded 56182597 bytes. 06:54:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/B8rXrdc_TV-X2rzihdjt2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 06:54:21 INFO - mkdir: /builds/slave/test-pgo/properties 06:54:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 06:54:21 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 06:54:21 INFO - Contents: 06:54:21 INFO - build_url:https://queue.taskcluster.net/v1/task/B8rXrdc_TV-X2rzihdjt2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 06:54:22 INFO - Running post-action listener: _resource_record_post_action 06:54:22 INFO - Running post-action listener: set_extra_try_arguments 06:54:22 INFO - ##### 06:54:22 INFO - ##### Running populate-webroot step. 06:54:22 INFO - ##### 06:54:22 INFO - Running pre-action listener: _resource_record_pre_action 06:54:22 INFO - Running main action method: populate_webroot 06:54:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:54:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:54:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:54:22 INFO - '--tppagecycles', 06:54:22 INFO - '7'], 06:54:22 INFO - 'tests': ['tsvgm']}}, 06:54:22 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:54:22 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:54:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:54:22 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 06:54:22 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:54:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:54:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:54:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:54:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:54:22 INFO - 'talos_options': ['--e10s'], 06:54:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:54:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:54:22 INFO - 'tests': ['damp', 'tps']}, 06:54:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:54:22 INFO - 'talos_options': ['--e10s'], 06:54:22 INFO - 'tests': ['damp', 'tps']}, 06:54:22 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:54:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:54:22 INFO - 'other': {'tests': ['a11yr', 06:54:22 INFO - 'ts_paint', 06:54:22 INFO - 'tpaint', 06:54:22 INFO - 'sessionrestore', 06:54:22 INFO - 'sessionrestore_no_auto_restore', 06:54:22 INFO - 'tabpaint']}, 06:54:22 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:54:22 INFO - 'tests': ['a11yr', 06:54:22 INFO - 'ts_paint', 06:54:22 INFO - 'tpaint', 06:54:22 INFO - 'sessionrestore', 06:54:22 INFO - 'sessionrestore_no_auto_restore', 06:54:22 INFO - 'tabpaint']}, 06:54:22 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:54:22 INFO - 'tests': ['a11yr', 06:54:22 INFO - 'ts_paint', 06:54:22 INFO - 'tpaint', 06:54:22 INFO - 'sessionrestore', 06:54:22 INFO - 'sessionrestore_no_auto_restore', 06:54:22 INFO - 'tabpaint']}, 06:54:22 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:54:22 INFO - 'tests': ['a11yr', 06:54:22 INFO - 'ts_paint', 06:54:22 INFO - 'tpaint', 06:54:22 INFO - 'sessionrestore', 06:54:22 INFO - 'sessionrestore_no_auto_restore', 06:54:22 INFO - 'tabpaint']}, 06:54:22 INFO - 'other_l64': {'tests': ['a11yr', 06:54:22 INFO - 'ts_paint', 06:54:22 INFO - 'tpaint', 06:54:22 INFO - 'sessionrestore', 06:54:22 INFO - 'sessionrestore_no_auto_restore', 06:54:22 INFO - 'tabpaint']}, 06:54:22 INFO - 'other_nol64': {'tests': ['a11yr', 06:54:22 INFO - 'ts_paint', 06:54:22 INFO - 'tpaint', 06:54:22 INFO - 'sessionrestore', 06:54:22 INFO - 'sessionrestore_no_auto_restore', 06:54:22 INFO - 'tabpaint']}, 06:54:22 INFO - 'svgr': {'tests': ['tsvgx', 06:54:22 INFO - 'tsvgr_opacity', 06:54:22 INFO - 'tart', 06:54:22 INFO - 'tscrollx', 06:54:22 INFO - 'cart']}, 06:54:22 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:54:22 INFO - 'tests': ['tsvgx', 06:54:22 INFO - 'tsvgr_opacity', 06:54:22 INFO - 'tart', 06:54:22 INFO - 'tscrollx', 06:54:22 INFO - 'cart']}, 06:54:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:54:22 INFO - 'tests': ['tp5o']}, 06:54:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:54:22 INFO - 'talos_options': ['--e10s'], 06:54:22 INFO - 'tests': ['tp5o']}, 06:54:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:54:22 INFO - 'talos_options': ['--xperf_path', 06:54:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:54:22 INFO - 'tests': ['tp5n']}, 06:54:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:54:22 INFO - 'talos_options': ['--e10s', 06:54:22 INFO - '--xperf_path', 06:54:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:54:22 INFO - 'tests': ['tp5n']}}, 06:54:22 INFO - 'talos.zip': {'path': '', 06:54:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:54:22 INFO - Running post-action listener: _resource_record_post_action 06:54:22 INFO - ##### 06:54:22 INFO - ##### Running create-virtualenv step. 06:54:22 INFO - ##### 06:54:22 INFO - Running pre-action listener: _resource_record_pre_action 06:54:22 INFO - Running main action method: create_virtualenv 06:54:22 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 06:54:22 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 06:54:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 06:54:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:54:22 INFO - Using real prefix '/usr' 06:54:22 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 06:54:23 INFO - Installing distribute.............................................................................................................................................................................................done. 06:54:24 INFO - Installing pip.................done. 06:54:24 INFO - Return code: 0 06:54:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 06:54:24 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')]} 06:54:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:24 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')]} 06:54:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:24 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 0x7f1f91793f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16026d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1691920>, '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 0x1692820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1692cb0>, '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': '0333a256a5e4f052382dd180000001b1-1457273634.917430-1353739975', '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 06:54:24 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 06:54:24 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 06:54:24 INFO - Using env: {'DISPLAY': ':0', 06:54:24 INFO - 'HOME': '/home/cltbld', 06:54:24 INFO - 'LANG': 'en_US.UTF-8', 06:54:24 INFO - 'LANGUAGE': 'en_US:en', 06:54:24 INFO - 'LOGNAME': 'cltbld', 06:54:24 INFO - 'MAIL': '/var/mail/cltbld', 06:54:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:24 INFO - 'MOZ_NO_REMOTE': '1', 06:54:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:24 INFO - 'NO_EM_RESTART': '1', 06:54:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:54:24 INFO - 'PWD': '/builds/slave/test-pgo', 06:54:24 INFO - 'SHELL': '/bin/bash', 06:54:24 INFO - 'SHLVL': '1', 06:54:24 INFO - 'TERM': 'linux', 06:54:24 INFO - 'TMOUT': '86400', 06:54:24 INFO - 'USER': 'cltbld', 06:54:24 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1457273634.917430-1353739975', 06:54:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:24 INFO - '_': '/tools/buildbot/bin/python'} 06:54:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:25 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 06:54:25 INFO - Cleaning up... 06:54:25 INFO - Return code: 0 06:54:25 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 06:54: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')]} 06:54:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54: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')]} 06:54:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:25 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 0x7f1f91793f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16026d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1691920>, '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 0x1692820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1692cb0>, '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': '0333a256a5e4f052382dd180000001b1-1457273634.917430-1353739975', '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 06:54:25 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 06:54:25 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 06:54:25 INFO - Using env: {'DISPLAY': ':0', 06:54:25 INFO - 'HOME': '/home/cltbld', 06:54:25 INFO - 'LANG': 'en_US.UTF-8', 06:54:25 INFO - 'LANGUAGE': 'en_US:en', 06:54:25 INFO - 'LOGNAME': 'cltbld', 06:54:25 INFO - 'MAIL': '/var/mail/cltbld', 06:54:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:25 INFO - 'MOZ_NO_REMOTE': '1', 06:54:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:25 INFO - 'NO_EM_RESTART': '1', 06:54:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:54:25 INFO - 'PWD': '/builds/slave/test-pgo', 06:54:25 INFO - 'SHELL': '/bin/bash', 06:54:25 INFO - 'SHLVL': '1', 06:54:25 INFO - 'TERM': 'linux', 06:54:25 INFO - 'TMOUT': '86400', 06:54:25 INFO - 'USER': 'cltbld', 06:54:25 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1457273634.917430-1353739975', 06:54:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:25 INFO - '_': '/tools/buildbot/bin/python'} 06:54:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:25 INFO - Downloading/unpacking psutil>=0.7.1 06:54:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 06:54:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:54:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:54:27 INFO - Installing collected packages: psutil 06:54:27 INFO - Running setup.py install for psutil 06:54:27 INFO - building 'psutil._psutil_linux' extension 06:54:27 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 06:54:27 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 06:54:27 INFO - building 'psutil._psutil_posix' extension 06:54:27 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 06:54:27 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 06:54:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:54:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:54:27 INFO - Successfully installed psutil 06:54:27 INFO - Cleaning up... 06:54:27 INFO - Return code: 0 06:54:27 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 06:54:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:27 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1f91793f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16026d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1691920>, '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 0x1692820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1692cb0>, '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': '0333a256a5e4f052382dd180000001b1-1457273634.917430-1353739975', '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 06:54:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 06:54:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 06:54:27 INFO - Using env: {'DISPLAY': ':0', 06:54:27 INFO - 'HOME': '/home/cltbld', 06:54:27 INFO - 'LANG': 'en_US.UTF-8', 06:54:27 INFO - 'LANGUAGE': 'en_US:en', 06:54:27 INFO - 'LOGNAME': 'cltbld', 06:54:27 INFO - 'MAIL': '/var/mail/cltbld', 06:54:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:27 INFO - 'MOZ_NO_REMOTE': '1', 06:54:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:27 INFO - 'NO_EM_RESTART': '1', 06:54:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:54:27 INFO - 'PWD': '/builds/slave/test-pgo', 06:54:27 INFO - 'SHELL': '/bin/bash', 06:54:27 INFO - 'SHLVL': '1', 06:54:27 INFO - 'TERM': 'linux', 06:54:27 INFO - 'TMOUT': '86400', 06:54:27 INFO - 'USER': 'cltbld', 06:54:27 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1457273634.917430-1353739975', 06:54:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:27 INFO - '_': '/tools/buildbot/bin/python'} 06:54:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:28 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:54:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:29 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:54:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:54:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:54:30 INFO - Installing collected packages: mozsystemmonitor 06:54:30 INFO - Running setup.py install for mozsystemmonitor 06:54:30 INFO - Successfully installed mozsystemmonitor 06:54:30 INFO - Cleaning up... 06:54:30 INFO - Return code: 0 06:54:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 06:54:30 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')]} 06:54:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:30 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')]} 06:54:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:30 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 0x7f1f91793f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16026d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1691920>, '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 0x1692820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1692cb0>, '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': '0333a256a5e4f052382dd180000001b1-1457273634.917430-1353739975', '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 06:54:30 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 06:54:30 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 06:54:30 INFO - Using env: {'DISPLAY': ':0', 06:54:30 INFO - 'HOME': '/home/cltbld', 06:54:30 INFO - 'LANG': 'en_US.UTF-8', 06:54:30 INFO - 'LANGUAGE': 'en_US:en', 06:54:30 INFO - 'LOGNAME': 'cltbld', 06:54:30 INFO - 'MAIL': '/var/mail/cltbld', 06:54:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:30 INFO - 'MOZ_NO_REMOTE': '1', 06:54:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:30 INFO - 'NO_EM_RESTART': '1', 06:54:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:54:30 INFO - 'PWD': '/builds/slave/test-pgo', 06:54:30 INFO - 'SHELL': '/bin/bash', 06:54:30 INFO - 'SHLVL': '1', 06:54:30 INFO - 'TERM': 'linux', 06:54:30 INFO - 'TMOUT': '86400', 06:54:30 INFO - 'USER': 'cltbld', 06:54:30 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1457273634.917430-1353739975', 06:54:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:30 INFO - '_': '/tools/buildbot/bin/python'} 06:54:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:30 INFO - Downloading/unpacking blobuploader==1.2.4 06:54:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:32 INFO - Downloading blobuploader-1.2.4.tar.gz 06:54:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:54:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:54:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 06:54:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:54:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:32 INFO - Downloading docopt-0.6.1.tar.gz 06:54:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 06:54:32 INFO - Installing collected packages: blobuploader, requests, docopt 06:54:32 INFO - Running setup.py install for blobuploader 06:54:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:54:33 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 06:54:33 INFO - Running setup.py install for requests 06:54:33 INFO - Running setup.py install for docopt 06:54:33 INFO - Successfully installed blobuploader requests docopt 06:54:33 INFO - Cleaning up... 06:54:33 INFO - Return code: 0 06:54:33 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:54:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:33 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 0x7f1f91793f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16026d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1691920>, '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 0x1692820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1692cb0>, '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': '0333a256a5e4f052382dd180000001b1-1457273634.917430-1353739975', '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 06:54:33 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 06:54:33 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 06:54:33 INFO - Using env: {'DISPLAY': ':0', 06:54:33 INFO - 'HOME': '/home/cltbld', 06:54:33 INFO - 'LANG': 'en_US.UTF-8', 06:54:33 INFO - 'LANGUAGE': 'en_US:en', 06:54:33 INFO - 'LOGNAME': 'cltbld', 06:54:33 INFO - 'MAIL': '/var/mail/cltbld', 06:54:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:33 INFO - 'MOZ_NO_REMOTE': '1', 06:54:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:33 INFO - 'NO_EM_RESTART': '1', 06:54:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:54:33 INFO - 'PWD': '/builds/slave/test-pgo', 06:54:33 INFO - 'SHELL': '/bin/bash', 06:54:33 INFO - 'SHLVL': '1', 06:54:33 INFO - 'TERM': 'linux', 06:54:33 INFO - 'TMOUT': '86400', 06:54:33 INFO - 'USER': 'cltbld', 06:54:33 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1457273634.917430-1353739975', 06:54:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:33 INFO - '_': '/tools/buildbot/bin/python'} 06:54:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:54:33 INFO - Running setup.py (path:/tmp/pip-rPbSkM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:54:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:54:33 INFO - Running setup.py (path:/tmp/pip-hqWEIA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:54:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:54:33 INFO - Running setup.py (path:/tmp/pip-AsAEnw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:54:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:54:33 INFO - Running setup.py (path:/tmp/pip-jM6fP0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:54:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:54:34 INFO - Running setup.py (path:/tmp/pip-3t1pyT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:54:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:54:34 INFO - Running setup.py (path:/tmp/pip-l2pMin-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:54:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:54:34 INFO - Running setup.py (path:/tmp/pip-4QgyKM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:54:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:54:34 INFO - Running setup.py (path:/tmp/pip-DtjGAt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:54:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:54:34 INFO - Running setup.py (path:/tmp/pip-rj9Ez5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:54:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:54:34 INFO - Running setup.py (path:/tmp/pip-b5g17U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:54:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:54:34 INFO - Running setup.py (path:/tmp/pip-2xOGiJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:54:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:54:34 INFO - Running setup.py (path:/tmp/pip-TN5bcJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:54:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:54:34 INFO - Running setup.py (path:/tmp/pip-r4s_H9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:54:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:54:34 INFO - Running setup.py (path:/tmp/pip-0ErcDj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:54:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:54:34 INFO - Running setup.py (path:/tmp/pip-ly9OJM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:54:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:54:34 INFO - Running setup.py (path:/tmp/pip-zAGYcG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:54:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:54:34 INFO - Running setup.py (path:/tmp/pip-zYLgff-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:54:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:54:34 INFO - Running setup.py install for manifestparser 06:54:35 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 06:54:35 INFO - Running setup.py install for mozcrash 06:54:35 INFO - Running setup.py install for mozdebug 06:54:35 INFO - Running setup.py install for mozdevice 06:54:35 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 06:54:35 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 06:54:35 INFO - Running setup.py install for mozfile 06:54:35 INFO - Running setup.py install for mozhttpd 06:54:35 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 06:54:35 INFO - Running setup.py install for mozinfo 06:54:35 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 06:54:35 INFO - Running setup.py install for mozInstall 06:54:35 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 06:54:35 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 06:54:35 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 06:54:35 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 06:54:35 INFO - Running setup.py install for mozleak 06:54:35 INFO - Running setup.py install for mozlog 06:54:35 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 06:54:36 INFO - Running setup.py install for moznetwork 06:54:36 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 06:54:36 INFO - Running setup.py install for mozprocess 06:54:36 INFO - Running setup.py install for mozprofile 06:54:36 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 06:54:36 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 06:54:36 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 06:54:36 INFO - Running setup.py install for mozrunner 06:54:36 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 06:54:36 INFO - Running setup.py install for mozscreenshot 06:54:36 INFO - Running setup.py install for moztest 06:54:36 INFO - Running setup.py install for mozversion 06:54:36 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 06:54:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:54:36 INFO - Cleaning up... 06:54:36 INFO - Return code: 0 06:54:36 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:54:36 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')]} 06:54:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:36 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')]} 06:54:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:36 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 0x7f1f91793f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16026d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1691920>, '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 0x1692820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1692cb0>, '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': '0333a256a5e4f052382dd180000001b1-1457273634.917430-1353739975', '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 06:54:36 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 06:54:36 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 06:54:36 INFO - Using env: {'DISPLAY': ':0', 06:54:36 INFO - 'HOME': '/home/cltbld', 06:54:36 INFO - 'LANG': 'en_US.UTF-8', 06:54:36 INFO - 'LANGUAGE': 'en_US:en', 06:54:36 INFO - 'LOGNAME': 'cltbld', 06:54:36 INFO - 'MAIL': '/var/mail/cltbld', 06:54:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:36 INFO - 'MOZ_NO_REMOTE': '1', 06:54:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:36 INFO - 'NO_EM_RESTART': '1', 06:54:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:54:36 INFO - 'PWD': '/builds/slave/test-pgo', 06:54:36 INFO - 'SHELL': '/bin/bash', 06:54:36 INFO - 'SHLVL': '1', 06:54:36 INFO - 'TERM': 'linux', 06:54:36 INFO - 'TMOUT': '86400', 06:54:36 INFO - 'USER': 'cltbld', 06:54:36 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1457273634.917430-1353739975', 06:54:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:36 INFO - '_': '/tools/buildbot/bin/python'} 06:54:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:54:36 INFO - Running setup.py (path:/tmp/pip-oc9k0q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:54:37 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)) 06:54:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:54:37 INFO - Running setup.py (path:/tmp/pip-jcsTn8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:54:37 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)) 06:54:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:54:37 INFO - Running setup.py (path:/tmp/pip-vV9__j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:54:37 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)) 06:54:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:54:37 INFO - Running setup.py (path:/tmp/pip-4LpV8N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:54:37 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)) 06:54:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:54:37 INFO - Running setup.py (path:/tmp/pip-277pPE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:54:37 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)) 06:54:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:54:37 INFO - Running setup.py (path:/tmp/pip-st4kMv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:54:37 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)) 06:54:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:54:37 INFO - Running setup.py (path:/tmp/pip-llyZPW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:54:37 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)) 06:54:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:54:37 INFO - Running setup.py (path:/tmp/pip-Lruzb5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:54:37 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)) 06:54:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:54:37 INFO - Running setup.py (path:/tmp/pip-FLcITj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:54:37 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)) 06:54:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:54:37 INFO - Running setup.py (path:/tmp/pip-IHxDkU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:54:37 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)) 06:54:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:54:37 INFO - Running setup.py (path:/tmp/pip-BBaCBN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:54:37 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)) 06:54:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:54:37 INFO - Running setup.py (path:/tmp/pip-D19_e1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:54:37 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)) 06:54:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:54:37 INFO - Running setup.py (path:/tmp/pip-vLvJUq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:54:37 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)) 06:54:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:54:37 INFO - Running setup.py (path:/tmp/pip-jeB56F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:54:38 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)) 06:54:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:54:38 INFO - Running setup.py (path:/tmp/pip-QZb03d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:54:38 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)) 06:54:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:54:38 INFO - Running setup.py (path:/tmp/pip-0wkiLC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:54:38 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)) 06:54:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:54:38 INFO - Running setup.py (path:/tmp/pip-rEVst_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:54:38 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)) 06:54:38 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)) 06:54:38 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)) 06:54:38 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)) 06:54:38 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)) 06:54:38 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)) 06:54:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 06:54:38 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 06:54:38 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 06:54:38 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 06:54:38 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 06:54:38 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 06:54:38 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 06:54:40 INFO - Downloading blessings-1.6.tar.gz 06:54:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 06:54:40 INFO - Installing collected packages: blessings 06:54:40 INFO - Running setup.py install for blessings 06:54:40 INFO - Successfully installed blessings 06:54:40 INFO - Cleaning up... 06:54:40 INFO - Return code: 0 06:54:40 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 06:54:40 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:54:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:54:40 INFO - Reading from file tmpfile_stdout 06:54:40 INFO - Current package versions: 06:54:40 INFO - argparse == 1.2.1 06:54:40 INFO - blessings == 1.6 06:54:40 INFO - blobuploader == 1.2.4 06:54:40 INFO - docopt == 0.6.1 06:54:40 INFO - manifestparser == 1.1 06:54:40 INFO - mozInstall == 1.12 06:54:40 INFO - mozcrash == 0.17 06:54:40 INFO - mozdebug == 0.1 06:54:40 INFO - mozdevice == 0.48 06:54:40 INFO - mozfile == 1.2 06:54:40 INFO - mozhttpd == 0.7 06:54:40 INFO - mozinfo == 0.9 06:54:40 INFO - mozleak == 0.1 06:54:40 INFO - mozlog == 3.1 06:54:40 INFO - moznetwork == 0.27 06:54:40 INFO - mozprocess == 0.22 06:54:40 INFO - mozprofile == 0.28 06:54:40 INFO - mozrunner == 6.11 06:54:40 INFO - mozscreenshot == 0.1 06:54:40 INFO - mozsystemmonitor == 0.0 06:54:40 INFO - moztest == 0.7 06:54:40 INFO - mozversion == 1.4 06:54:40 INFO - psutil == 3.1.1 06:54:40 INFO - requests == 1.2.3 06:54:40 INFO - wsgiref == 0.1.2 06:54:40 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:54:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:40 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 0x7f1f91793f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16026d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1691920>, '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 0x1692820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1692cb0>, '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': '0333a256a5e4f052382dd180000001b1-1457273634.917430-1353739975', '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 06:54:40 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 06:54:40 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 06:54:40 INFO - Using env: {'DISPLAY': ':0', 06:54:40 INFO - 'HOME': '/home/cltbld', 06:54:40 INFO - 'LANG': 'en_US.UTF-8', 06:54:40 INFO - 'LANGUAGE': 'en_US:en', 06:54:40 INFO - 'LOGNAME': 'cltbld', 06:54:40 INFO - 'MAIL': '/var/mail/cltbld', 06:54:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:40 INFO - 'MOZ_NO_REMOTE': '1', 06:54:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:40 INFO - 'NO_EM_RESTART': '1', 06:54:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:54:40 INFO - 'PWD': '/builds/slave/test-pgo', 06:54:40 INFO - 'SHELL': '/bin/bash', 06:54:40 INFO - 'SHLVL': '1', 06:54:40 INFO - 'TERM': 'linux', 06:54:40 INFO - 'TMOUT': '86400', 06:54:40 INFO - 'USER': 'cltbld', 06:54:40 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1457273634.917430-1353739975', 06:54:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:40 INFO - '_': '/tools/buildbot/bin/python'} 06:54:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:40 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)) 06:54:40 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)) 06:54:40 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)) 06:54:40 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)) 06:54:40 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)) 06:54:40 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)) 06:54:40 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)) 06:54:40 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)) 06:54:40 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)) 06:54:40 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)) 06:54:40 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)) 06:54:40 INFO - Cleaning up... 06:54:40 INFO - Return code: 0 06:54:40 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 06:54:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:40 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 0x7f1f91793f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16026d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1691920>, '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 0x1692820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1692cb0>, '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': '0333a256a5e4f052382dd180000001b1-1457273634.917430-1353739975', '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 06:54:40 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 06:54:40 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 06:54:40 INFO - Using env: {'DISPLAY': ':0', 06:54:40 INFO - 'HOME': '/home/cltbld', 06:54:40 INFO - 'LANG': 'en_US.UTF-8', 06:54:40 INFO - 'LANGUAGE': 'en_US:en', 06:54:40 INFO - 'LOGNAME': 'cltbld', 06:54:40 INFO - 'MAIL': '/var/mail/cltbld', 06:54:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:40 INFO - 'MOZ_NO_REMOTE': '1', 06:54:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:40 INFO - 'NO_EM_RESTART': '1', 06:54:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:54:40 INFO - 'PWD': '/builds/slave/test-pgo', 06:54:40 INFO - 'SHELL': '/bin/bash', 06:54:40 INFO - 'SHLVL': '1', 06:54:40 INFO - 'TERM': 'linux', 06:54:40 INFO - 'TMOUT': '86400', 06:54:40 INFO - 'USER': 'cltbld', 06:54:40 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1457273634.917430-1353739975', 06:54:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:40 INFO - '_': '/tools/buildbot/bin/python'} 06:54:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:40 INFO - Downloading/unpacking jsonschema 06:54:40 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 06:54:40 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 06:54:40 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 06:54:40 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 06:54:40 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 06:54:40 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 06:54:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:54:42 INFO - Downloading/unpacking functools32 (from jsonschema) 06:54:42 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 06:54:42 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 06:54:42 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 06:54:42 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 06:54:42 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 06:54:42 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 06:54:42 INFO - Downloading functools32-3.2.3-2.tar.gz 06:54:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 06:54:43 INFO - warning: no files found matching '*.txt' 06:54:43 INFO - no previously-included directories found matching 'build' 06:54:43 INFO - no previously-included directories found matching 'dist' 06:54:43 INFO - no previously-included directories found matching '.git*' 06:54:43 INFO - Installing collected packages: jsonschema, functools32 06:54:43 INFO - Running setup.py install for functools32 06:54:43 INFO - warning: no files found matching '*.txt' 06:54:43 INFO - no previously-included directories found matching 'build' 06:54:43 INFO - no previously-included directories found matching 'dist' 06:54:43 INFO - no previously-included directories found matching '.git*' 06:54:43 INFO - Successfully installed jsonschema functools32 06:54:43 INFO - Cleaning up... 06:54:43 INFO - Return code: 0 06:54:43 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 06:54:43 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')]} 06:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:43 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')]} 06:54:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:43 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 0x7f1f91793f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16026d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1691920>, '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 0x1692820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1692cb0>, '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': '0333a256a5e4f052382dd180000001b1-1457273634.917430-1353739975', '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 06:54:43 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 06:54:43 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 06:54:43 INFO - Using env: {'DISPLAY': ':0', 06:54:43 INFO - 'HOME': '/home/cltbld', 06:54:43 INFO - 'LANG': 'en_US.UTF-8', 06:54:43 INFO - 'LANGUAGE': 'en_US:en', 06:54:43 INFO - 'LOGNAME': 'cltbld', 06:54:43 INFO - 'MAIL': '/var/mail/cltbld', 06:54:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:43 INFO - 'MOZ_NO_REMOTE': '1', 06:54:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:43 INFO - 'NO_EM_RESTART': '1', 06:54:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:54:43 INFO - 'PWD': '/builds/slave/test-pgo', 06:54:43 INFO - 'SHELL': '/bin/bash', 06:54:43 INFO - 'SHLVL': '1', 06:54:43 INFO - 'TERM': 'linux', 06:54:43 INFO - 'TMOUT': '86400', 06:54:43 INFO - 'USER': 'cltbld', 06:54:43 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1457273634.917430-1353739975', 06:54:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:43 INFO - '_': '/tools/buildbot/bin/python'} 06:54:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:43 INFO - Downloading/unpacking flake8 06:54:43 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 06:54:43 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 06:54:43 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 06:54:43 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 06:54:43 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 06:54:43 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 06:54:45 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:54:45 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:54:45 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 06:54:45 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 06:54:45 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 06:54:45 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 06:54:45 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 06:54:45 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 06:54:45 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:54:45 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:54:45 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 06:54:45 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 06:54:45 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 06:54:45 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 06:54:45 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 06:54:45 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 06:54:45 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:54:45 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 06:54:45 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 06:54:45 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 06:54:45 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 06:54:45 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 06:54:45 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 06:54:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 06:54:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:54:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:54:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:54:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:54:46 INFO - no previously-included directories found matching 'docs/_build' 06:54:46 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:54:46 INFO - Running setup.py install for pep8 06:54:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:54:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:54:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:54:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:54:46 INFO - no previously-included directories found matching 'docs/_build' 06:54:46 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 06:54:46 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:54:46 INFO - Cleaning up... 06:54:46 INFO - Return code: 0 06:54:46 INFO - Running post-action listener: _resource_record_post_action 06:54:46 INFO - Running post-action listener: _start_resource_monitoring 06:54:46 INFO - Starting resource monitoring. 06:54:46 INFO - ##### 06:54:46 INFO - ##### Running install step. 06:54:46 INFO - ##### 06:54:46 INFO - Running pre-action listener: _resource_record_pre_action 06:54:46 INFO - Running main action method: install 06:54:46 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:54:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:54:46 INFO - Reading from file tmpfile_stdout 06:54:46 INFO - Detecting whether we're running mozinstall >=1.0... 06:54:46 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 06:54:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 06:54:46 INFO - Reading from file tmpfile_stdout 06:54:46 INFO - Output received: 06:54:46 INFO - Usage: mozinstall [options] installer 06:54:46 INFO - Options: 06:54:46 INFO - -h, --help show this help message and exit 06:54:46 INFO - -d DEST, --destination=DEST 06:54:46 INFO - Directory to install application into. [default: 06:54:46 INFO - "/builds/slave/test-pgo"] 06:54:46 INFO - --app=APP Application being installed. [default: firefox] 06:54:46 INFO - mkdir: /builds/slave/test-pgo/build/application 06:54:46 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 06:54:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 06:55:02 INFO - Reading from file tmpfile_stdout 06:55:02 INFO - Output received: 06:55:02 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 06:55:02 INFO - Running post-action listener: _resource_record_post_action 06:55:02 INFO - ##### 06:55:02 INFO - ##### Running run-tests step. 06:55:02 INFO - ##### 06:55:02 INFO - Running pre-action listener: _resource_record_pre_action 06:55:02 INFO - Running main action method: run_tests 06:55:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 06:55:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 06:55:02 INFO - Python 2.7.3 06:55:02 INFO - Return code: 0 06:55:02 INFO - grabbing minidump binary from tooltool 06:55: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')]} 06:55:02 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 0x1691920>, '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 0x1692820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1692cb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 06:55:02 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 06:55:02 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 06:55:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:55:02 INFO - Return code: 0 06:55:02 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 06:55:02 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 06:55:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 06:55:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 06:55:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 06:55:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 06:55:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 06:55:03 INFO - Return code: 0 06:55:03 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/B8rXrdc_TV-X2rzihdjt2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 06:55:03 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/B8rXrdc_TV-X2rzihdjt2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --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 06:55:03 INFO - Using env: {'DISPLAY': ':0', 06:55:03 INFO - 'HOME': '/home/cltbld', 06:55:03 INFO - 'LANG': 'en_US.UTF-8', 06:55:03 INFO - 'LANGUAGE': 'en_US:en', 06:55:03 INFO - 'LOGNAME': 'cltbld', 06:55:03 INFO - 'MAIL': '/var/mail/cltbld', 06:55:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:55:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 06:55:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:03 INFO - 'MOZ_NO_REMOTE': '1', 06:55:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:55:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:55:03 INFO - 'NO_EM_RESTART': '1', 06:55:03 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:55:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:55:03 INFO - 'PWD': '/builds/slave/test-pgo', 06:55:03 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 06:55:03 INFO - 'SHELL': '/bin/bash', 06:55:03 INFO - 'SHLVL': '1', 06:55:03 INFO - 'TERM': 'linux', 06:55:03 INFO - 'TMOUT': '86400', 06:55:03 INFO - 'USER': 'cltbld', 06:55:03 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1457273634.917430-1353739975', 06:55:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:03 INFO - '_': '/tools/buildbot/bin/python'} 06:55:03 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/B8rXrdc_TV-X2rzihdjt2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 06:55:04 INFO - mozversion application_buildid: 20160306043006 06:55:04 INFO - mozversion application_changeset: b972f49b8c7e563c3a50126e5647bd40d1c3b37c 06:55:04 INFO - mozversion application_display_name: Nightly 06:55:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:55:04 INFO - mozversion application_name: Firefox 06:55:04 INFO - mozversion application_remotingname: firefox 06:55:04 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 06:55:04 INFO - mozversion application_vendor: Mozilla 06:55:04 INFO - mozversion application_version: 47.0a1 06:55:04 INFO - mozversion platform_buildid: 20160306043006 06:55:04 INFO - mozversion platform_changeset: b972f49b8c7e563c3a50126e5647bd40d1c3b37c 06:55:04 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 06:55:04 INFO - mozversion platform_version: 47.0a1 06:55:04 INFO - using testdate: 1457276104 06:55:04 INFO - actual date: 1457276104 06:55:04 INFO - starting webserver on 'localhost:46601' 06:55:04 INFO - SUITE-START | Running 2 tests 06:55:04 INFO - TEST-START | dromaeo_css 06:55:04 INFO - operating with platform_type : linux_ 06:55:04 INFO - Initialising browser for dromaeo_css test... 06:55:04 INFO - TEST-INFO | started process 5133 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDqPxkR/profile http://localhost:46601/getInfo.html) 06:55:08 INFO - PROCESS | 5133 | __metrics Screen width/height:1600/1200 06:55:08 INFO - PROCESS | 5133 | colorDepth:24 06:55:08 INFO - PROCESS | 5133 | Browser inner width/height: 1024/697 06:55:08 INFO - PROCESS | 5133 | __metrics 06:55:08 INFO - PROCESS | 5133 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:55:09 INFO - TEST-INFO | 5133: exit 0 06:55:09 INFO - Browser initialized. 06:55:09 INFO - Running cycle 1/1 for dromaeo_css test... 06:55:09 INFO - TEST-INFO | started process 5228 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDqPxkR/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:55:21 INFO - PROCESS | 5228 | RSS: Main: 156749824 06:55:21 INFO - PROCESS | 5228 | 06:56:13 INFO - PROCESS | 5228 | 1457276173162 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] 06:58:21 INFO - PROCESS | 5228 | Cycle 1(1): loaded http://localhost:46601/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46601/tests/dromaeo/cssquery-ext.html) 06:58:22 INFO - PROCESS | 5228 | RSS: Main: 282701824 06:58:22 INFO - PROCESS | 5228 | 07:01:24 INFO - PROCESS | 5228 | Cycle 1(1): loaded http://localhost:46601/tests/dromaeo/cssquery-ext.html (next: http://localhost:46601/tests/dromaeo/cssquery-jquery.html) 07:01:25 INFO - PROCESS | 5228 | RSS: Main: 245706752 07:01:25 INFO - PROCESS | 5228 | 07:04:27 INFO - PROCESS | 5228 | Cycle 1(1): loaded http://localhost:46601/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46601/tests/dromaeo/cssquery-mootools.html) 07:04:27 INFO - PROCESS | 5228 | RSS: Main: 242786304 07:04:27 INFO - PROCESS | 5228 | 07:07:29 INFO - PROCESS | 5228 | Cycle 1(1): loaded http://localhost:46601/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46601/tests/dromaeo/cssquery-prototype.html) 07:07:30 INFO - PROCESS | 5228 | RSS: Main: 223281152 07:07:30 INFO - PROCESS | 5228 | 07:10:32 INFO - PROCESS | 5228 | Cycle 1(1): loaded http://localhost:46601/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46601/tests/dromaeo/cssquery-yui.html) 07:10:33 INFO - PROCESS | 5228 | RSS: Main: 222851072 07:10:33 INFO - PROCESS | 5228 | 07:13:36 INFO - PROCESS | 5228 | Cycle 1(1): loaded http://localhost:46601/tests/dromaeo/cssquery-yui.html (next: http://localhost:46601/tests/dromaeo/cssquery-dojo.html) 07:13:36 INFO - PROCESS | 5228 | RSS: Main: 273383424 07:13:36 INFO - PROCESS | 5228 | 07:13:36 INFO - PROCESS | 5228 | __start_tp_report 07:13:36 INFO - PROCESS | 5228 | _x_x_mozilla_page_load 07:13:36 INFO - PROCESS | 5228 | _x_x_mozilla_page_load_details 07:13:36 INFO - PROCESS | 5228 | |i|pagename|runs| 07:13:36 INFO - PROCESS | 5228 | |0;dojo.html;3181.411438883805;3187.9521807172896;3230.741540676746;3259.250372414345;3290.341931613677;5095.668781529198;5167.612429067821;5179.093658609742;5215.061288967993;5270.235815806705;5208.583313334933;5216;5251.55361794248;5272.789088436458;5316.362036555609;4640.698354606957;4736.952630473695;4800.447948485917;4873.805047798084;4916.778744956468;4671.439427268732;4750.311204875291;4854.17479028566;4865.075635629237;4969.950300496985;4735.479097299294;4738.90522189556;4742.549457801503;4742.976285118552;4744.549267819586;4735.857924262277;4736.739479328636;4747.928781068286;4812.422509298872;4834.564889159958;4676.766161691902;4684.3910291662205;4691.132140554008;4713.410823647044;4747.667663263573;5086.160783470723;5097.7196254206;5102.974485127551;5120.1039818031695;5153.896922061575;5499.367572729107;5573.972130139364;5675.858103547444;5725.198472213893;5727.828165155052;5643.717814109278;5653.378128405872;5666.121751128581;5666.376698563155;5667.4049224831215;5177.275181474596;5215.530602245816;5281.392639846428;5283.577313814885;5285.312909321802;5719.28508936383;5785;5789.739461724233;5803.361630220672;5826.038703613941;5475.8500714850325;5510.476504732044;5511.669299842022;5513.062779327524;5520.779168833282;5502.0921547944145;5605.215269862222;5616.466435688603;5620.57845661577;5643.238162848045;5669.744861481243;5670.943290567042;5671.092625179951;5671.858203544862;5720.170575266563;5643.943560564342;5672.574556908248;5673.319201695823;5674;5676.0918253080135;4232.534421213664;4250.659947204216;4288.742675439484;4303.655707543389;4355.063661312833;3851.67260782831;3854.171353159028;3857.479240302523;3882.4176373544196;3888.650021498079;5265.368155821249;5269.209618557171;5269.998700247017;5272.182811664198;5313.654612450178;5591.3569939456665;5622.550195984311;5643.435656434323;5731.197632331477;5739.569532285095;5260.158374660036;5277.815276465382;5293.497117773805;5295.417504074549;5299.152135658276;4787.138315103315;4807.855764327076;4808.495108013678;4810.903781924412;4852.878678033077;5809.24479817621;5809.419058094157;5849.970750146222;5908.822735317862;5917.52659787216;5588.692621905834;5613.382527922007;5618.4662457066515;5618.887622247614;5630.296212973379;5850.12248162779;5893.116032595145;5905.970470147622;5908.05471124618;5910.497607703222;5547.833564993057;5584.609077364546;5587.888242235052;5598.804041858515;5629.4652008059165;5643.125315575928;5661.094224923992;5662.377138514842;5666.320041595035;5667.801626943037;5407.918881216706;5495.313085864267;5495.53287970527;5501.559875209893;5507.228987941771;5506;5517.69652669107;5539.944600554104;5547.306586676666;5590.916136257878;5412.891742165213;5432.972835135799;5450.400455949763;5453.836384908459;5454.209139674805;5455.945440545703;5531.363893152178;5537.031019571639;5548.361938377138;5597.692126933058;5337.839864804062;5362.222477740784;5415.729213539386;5450.482204190595;5465.344158700981 07:13:36 INFO - PROCESS | 5228 | |1;ext.html;529.9655522391042;538.946359866461;541.2638811216747;543.3968295192336;559.4880684173982;28618.57072143917;29139.27151821203;37088.81455592718;37273.44089838654;37281.81359093208;39414.21171576574;39886.60113398865;39906.600933990725;39943.80168594947;40104;8368.079511253758;8554.828903421927;8555.058943516207;8563.015253245863;8570.357223208253;8599.61301741423;8741.213290803826;8756.781080473007;8762.737117886441;8770.517621530813;8782.692605758799;8863.069377715343;8865.95567022164;8867.113288671146;8871.024187339388;8661.263792577638;8718.912810871874;8724.040355560883;8731.869021964643;8739.781505462352;8734.432261903019;8847.336449766293;8866.556672166365;8871.911280887238;8873.423227490193;40024.19951600952;40389;40504;40570;40637.59362406397;3328.8834890778708;3453.5510383649967;3462.8961131166106;3612.747107702462;3751.7561358511884;28776.568351474743;30597.38805223883;30901.38197236065;31060.844695776603;31185.37629247425;3769.6418840210135;3777.7355585109053;3883.98058009711;3981.2634662587516;3988.880333589997;196642;197266;197469;197790;198218;59378.40621593815;59961.70019149876;59988.70005650031;60321.09518357228;60323.39676603265;63417;65098;66597.33402666009;66633;66724;15701.607459813597;15880;15923.044617322766;15936.760948585781;15949.760753588705;12127.09046821492;12181.512739490321;12200.267983920992;12201.633950981484;12202.633920982385;20069.59860802805;20359;20380.49048773763;20411.59176816485;20507;7985.5208687478935;8110.391720620859;8147.551884646283;8222.465539739898;8240.83518329642;945.2107490245585;960.7406000379858;983.5770618633914;1020.6733845169623;1046.49768111307;28744.856275718488;29050.128496144727;29110.12669619915;29582.852085739865;29615.25961850971;1065.387402243713;1073.7208325835338;1073.7530368015243;1075.1613741281813;1086.7772106718103;14934;15107.622309442351;15164.241787910782;15348.07911525312;15352.462663806937;297901;468516;470281;471404;472908;51754.22368664473;51928.22107668388;52520.212196817076;52550.21174682383;52657;1290.8192853000587;1291.8126871603754;1330.813686083949;1396.7136736968896;1506.6835964447368;27952.720472795827;33019.33961320808;33456.665433345355;33512.83243583766;33783.83108084444;49913;50604.74697626635;50853.49146508487;50902.490975091256;50935.999999998516;285685;286740;287611;287910;289519;32181.517277240393;42764.78617607016;44349.55650443454;44897.775511122236;44975.550244498445;40020;40094.799526002185;40935;40996.590034099274;41142.58857411507;34330.656693433746;34546.481802772476;34650.653493465754;34877.8256108728;35029.299414012086;34902.650973490956;35072.824635876656;35140.47289290612;35471.64528354786;35534.28931421409;37468.43797342988;37705.43441848319;41499.1700166001;42222.553699283766;42993;31881.36237275288;33256.1685957853;33678.49482257817;33716.83141584276;33811.492827607115;25695;26009.739902600733;26319.21042368732;26375.736242638097;26536.601950970366 07:13:36 INFO - PROCESS | 5228 | |2;jquery.html;339.141970813841;357.0662716995059;360.9909752256194;365.1892797988465;366.6993065686137;16656.666866662676;17017.574560635974;17549.824501754996;18400.35598754044;18827.058647067624;11314.830277545843;11622.535098596047;11633.185677002613;11638.534458621645;16994.83005169948;5055.519725626069;5191.688498690071;5215.895682086356;5218.843434696965;5418.7019713915715;5406.053940560386;5447.346318441772;5505.972470137664;5524.226608274845;5554.805581804638;5346.198070289449;5542.584306177053;5546.029444847156;5554.305711786027;5555.583331250152;5436.2661040759385;5450.91823622646;5462.453754624526;5462.5083742462975;5467.261919640838;4898.755062246909;4926.605871530305;4931.80272789088;4942.851714448572;4950.059488697136;19309.324173653855;19671.426285897236;20598.176072957063;20609.484762880897;20613.07241174151;2011.145263263122;2117.894105294729;2265.76209498002;2842.2183899427614;2873.583330417078;9859.408435493893;10219.386836789816;10330.638427654996;12609.117361784678;13250.734985300336;1814.4738025972583;1828.9634207315912;1850.5743678953781;1881.1158755385084;1884.7267146263714;59012.70493647547;59350.70324648392;59446.16369117521;60555.09167362493;61542.38457615456;10291.794164116676;10379.221558383151;10435.94782026085;10439.217058720475;10552.41961692099;13616.251106189255;13748.93125534386;13756.86243137576;13766.449342026408;13778.173309601456;7493.700251989969;7544.811379715441;7553.169151393342;7608.961955190189;7629.465937384441;7318.63406829667;7399.741009064657;7552.320291173821;7647.502912310682;7651.551503518821;4399.84600538986;4463.330500424962;4465.307877279027;4509.2559727644575;4607.815687372535;1772.2467951120723;1823.626156637886;1825.196913358118;1844.5296449405585;1848.9352872649392;914.8764916736288;953.5661274120258;965.546193289167;981.563204374061;1023.155896385485;16091.51725448215;16599.6680066398;16830.663386732198;16898.155092245583;17133.31466741341;899.2311573604604;935.2845073518764;948.4925564822787;973.3867663372172;1008.8839783424853;9383.906160938439;9547.856782148274;9640.614375424904;9644.662436814679;9903.207743380512;422504;434652;435123;438310;439088;47564;59544.106838397456;60612;69688;70224.6488767553;997.9650712225038;1021.7445638590352;1022.8005538919839;1036.1917704190744;1079.9514021869036;14675.853241467876;14880.479183228535;15010.699786004438;15101.848981510484;15330.463433779763;31690.207744806565;32636.184095397806;32841.67158328482;33243;34998.82500587481;44875;47763.522364777295;48131.27803083027;48173.27740083831;49049.509504905924;7537.660805263886;7741.5742134183165;7781.416393770377;7785.92214077852;7852.254035866584;10181.287309888237;11958.461869215733;12076.939615301868;12154.209976351509;12349.32078735678;10000;10174.796504069729;10257.948710256402;10318.226133040202;10574.995375439321;10198.031187037219;10450.700845813908;10594.947025264824;10679.733006674895;11059.281146725438;10209.825870025043;10477.842832357674;10495.422751748421;10581.259311848406;10990.890091098987;7822.765317040498;7897.763067107996;7990.360771138178;8025.23760242776;8038;8263.421560490708;9593.28050396237;10550.89449105499;10726.946365268124;10778.353298801783 07:13:36 INFO - PROCESS | 5228 | |3;mootools.html;1323.5963031275458;1481.8518148185183;1492.8656420922114;1676.120036980585;1822.835944764971;7253.31093546113;7388.335049845513;7397.334239918413;7419.146798118218;7459.216782237868;7572.12920514141;7730.342920851735;7735;7737.342325902291;7750.689972401097;2068.7207227024387;2241.9887900560475;2277.886105694717;2300.25241796416;2341.262502311775;2353.9411514712097;2362.527494501098;2365.8107351411845;2367.029517897662;2368.04094341791;2294.850834695748;2350.8589484630893;2354.105439932832;2356.45801465663;2361.752016038317;2286.634138537834;2295.36877358726;2356.092904231883;2356.670066190735;2363.83453158279;2327.49958758866;2349.3186975777003;2360.3273067175774;2362.7164740231283;2385.988070059656;7961.681532738684;8024.518528888286;8032.357411407073;8037.23646253605;8039.919600803975;4902.509749025105;4970.676906001098;5001.874953126165;5015.122353588144;5016.07202667504;3244.4971029490466;3356.2616224430585;3414.129397003773;3427.8971630851115;3429.176997520602;1067.4609322292192;1075;1084.073117484555;1089.7874914391696;1090.547422819529;11109.555617775279;11160.330380177296;11163;11189.384583847885;11201.607943722012;4523.7285762854335;4559.726416415026;4637.8840528986375;4660.277656963176;4678.2280923647895;9403.717888463358;9407.2003879671;9459.621615135455;9504.287178461644;9514.33399662031;4333.71830830995;5054.721990290569;5055.595552355802;5069.518395752398;5073.9746301269;3908.90227744303;3959.9604003960167;4384.56154384559;4493.393391892118;4529.071540334224;3753.6434038766274;3824.6557809796695;3831.923361532754;3855.9807200963814;3875.050612599931;1226.5400474821943;1238.0900038471716;1238.7089034076985;1249.5314257153568;1262.1165184370977;1335.1121504199793;1340.4705141469065;1359.0622470495327;1368.2953279061292;1381.053978025056;7579.317861392501;7689.269519395649;7696.538207707556;7707.152213256537;7714.5756983366455;502.74108833950544;509.59996402823606;509.77824646278987;513.8997895410433;517.6893863681836;5342.278792362981;5376.704281264568;5383.407825139231;5392.973035134799;5410.540104091117;8655.047944726075;8720.171583699539;8724.520151391735;8849.20357167858;9408.106229908148;8725.52009639476;8726.389152759373;8822.51476168804;8832.64669413229;8847.69033083839;7325.7802265932105;7359.852802943911;7499.887501687479;7501.287377699001;7526.247375262539;7441.293077157661;7467.402607791255;7483.663235154322;7489.887651685338;7567.129780075362;8338.37462190326;8598.570071496275;8758.03661597211;8857.64569417216;8859.955700221457;8711.607977640895;8998.280137588847;9085.364024518485;9115.817683646157;9169.587368568564;6293.339199383999;6644.269130395749;6780.355866192704;7231.3130252625915;7330.973663686981;7154.821129471805;7199.964000179965;7208.06295181623;7213.639318033972;7227.27727227273;6622.668866556749;6709.832254193684;6761.560498567577;6821.147356580427;6903.1716194057035;6776.119104516381;6801.693923773541;6856.24581296047;6905.75829845953;6928.896066558905;6861.176658800976;6991.056207412138;7047.506674532939;7091.326323999212;7091.432685385053;6521.902171467337;6563.7702680405955;6607.933920660732;6609.405153536205;6613.173353330833;6424.646644434601;6429;6434.967825161031;6437.0666253392055;6437.839054023687 07:13:36 INFO - PROCESS | 5228 | |4;prototype.html;330.14492464516894;333.83975691668013;336.4750988458005;336.7003367003366;341.3275846582234;5878.617889837157;5904.173415721797;5930.614510056854;5936.436038576334;5951.970240148804;5857.970710146444;5861.560382971273;5863.413658634135;5870.853228669274;5873.089671100986;4340.43574335336;4473;4558.65519671696;4607.447106347235;4636.119137363907;4602.424696912886;4603.608693261077;4607.447106347243;4611.838585649503;4615.653825963066;4566.041131362418;4574.130915126132;4575.862724118282;4579.175748365293;4583.839565615204;4356.629686476637;4429.756363400012;4509.233430316854;4516.5935065843905;4522.5025247222775;3986.5614782373914;4006.1186538961383;4022.939655905164;4024.557298697141;4026.2350153470748;5610.831675049755;5635.267415236034;5640.858978525529;5685.943140568624;5686.232358631573;5315.6013299002725;5318.228856815779;5325.520703136697;5325.600579956519;5326;6244;6253.093301471306;6253.843653908643;6256.968715156395;6257.749690012394;4377.422848657415;4399.868003959887;4451.332300154971;4453.755043472608;4471.932921006188;6459.386358295955;6493.577917435352;6497.317781632908;6498.1552398188405;6515.739370425177;4553.840615578439;4555.658325625592;4559.52125026874;4559.658025648089;4562.361269422284;4606.332081848113;4608.907821843544;4611.2852507861335;4611.8847028823875;4615.14619795339;5282.920756188661;5286.47135286476;5291.232771248147;5291.788328466818;5296.443873393238;6124.601900876429;6280.842978925563;6292.4966002719675;6297.464715499143;6298.370162983757;1613.0886049382061;1631.7307644238567;1640.1717132848073;1640.9097499637396;1649.496903444437;1036.6734478639205;1101.4492753623188;1101.8457415961773;1101.9779604408027;1136.091127098318;5867.735951882176;5918.201042859159;5927.1405646181065;5940.792072277536;5947.791827286024;6384.297727249998;6387.616742995435;6394.712237949303;6400.807975760735;6401.327860574573;5932.0508718604815;5936.5250779937505;5936.554758393051;5939.732712027969;5945.1973983512535;3415.9658403415647;3419.3845107880325;3448.620651728308;3453.5510383649967;3459.550258466383;6635.668216589152;6687.097241872382;6766;6777.661116944133;6781.898271525931;6469.5794773339585;6480.351964803576;6513.316101809337;6537.052127441494;6557.868842623217;6711.429528490133;6721.6975236114495;6728.697208625624;6737.3599508046655;6738.258791532928;6323.905141422974;6350.142730731292;6368.617882927039;6373;6385.042243663488;6205.193324867739;6350.68246587678;6357.809265722036;6364.140840986408;6365.108884756045;6716.83207919806;6721.764738234138;6745.426638735762;6753.020811982334;6758.695858686469;4586.65600080002;4589.173948689135;4590.60979816706;4595.885102872321;4599.310103484504;6371.331010243857;6391.648459334781;6405.455536279468;6423.357664233539;6473.320301368289;6197.194364732556;6212.099245609452;6214.533909956681;6215.595986260879;6222.81331560054;6053.788117415869;6217.813465596039;6224.470919971672;6225.8132256032395;6227.657478838707;6086.056661217518;6089.117078023751;6110.602810817282;6118.938810611837;6127.969360153171;6181.752729890754;6218.471429928507;6219.720112594853;6236.906446403217;6241.876462236841;5896.941030589639;6034.336223015553;6085.878282434415;6100.664463454553;6105.145279660762 07:13:36 INFO - PROCESS | 5228 | |5;yui.html;610.7068607068604;611.9785807496738;634.0647544871315;669.0633113640902;670.8624731929955;13665;13850.722985540284;13856.861431385683;13866.306684665764;13885.305734713262;14466.493672721457;14681.77977330341;14705.485308014222;14762.114273143592;14778.630534236649;695.6486974078083;837.9916200837974;838.7777239031661;839.3956351426978;847.5931552854634;842.3261390887296;843.2663582683043;846.5386364431369;847.3390755210945;847.9745607631781;886.7650072730731;894.4275663575316;897.0267260022883;897.3404547657467;897.3628723606247;726.2700985509582;878.44218920985;893.1381217125505;893.8033632600817;895.8342706599235;657.1719633262077;657.3098246840798;657.3656421553225;657.4411750012499;657.5265808617787;13746.037777355588;13766.449342026306;13801.171929684251;13803.585892423243;13805;12227.755444891141;12354.444050017772;12365.31990740509;12743.299118548475;12753.171043882117;10210;10234.283600147992;10348;10378.377297362182;10488.895111048869;3464.9653503465147;3497.8600855965733;3530.046887340404;3592.4252119660728;3604.8377822998027;49618.50381496175;49674;49894;49931;49999.50000499985;9975.057358079384;10001;10171.64399246023;10207.846882296772;10241.948790256001;16838.326466941184;16908.57728556796;16932.153392330336;16988.74516882248;17006.404775832787;7810.062792464941;7832.804179895548;7942.245486678757;8018.51888886657;8097.190280971973;4211.831526738896;4222.429971953747;4257.680673949466;4312.137572485515;4315.395844581761;3072.6466456357807;3073.6465306489595;3081.075677296802;3089.0423968569366;3098.612673415823;549.5768258441058;558.0206737176311;563.3352643880179;563.8252141836044;563.8562166647561;630.0958125090418;640.6892657061321;657.7829316325601;658.716751796732;670.1794911196276;7773.261540153676;7780.649870755717;7821.882671759929;7832.295093441618;8043.075046369625;471.9834805781781;539.8245570189704;557.9525740312118;568.6900639151672;576.3861487515783;3563.483294922222;3627.557477850944;3719.962800372016;3764.4541541476333;3828.559715632738;60461;60893.39106608966;61384;61497;61545.38454615397;50751.23873141906;51889.2216616751;51941;53166;53169;47520.7623961878;49182;49603.50396496061;50355.24467132923;51147.23279150741;8133.877991830009;8325.95837020811;8328.875066874123;8412.327013838756;8484.830303394021;32669.18327041843;32971;33487.330253394306;33645.49531756977;35651.28697425985;39360.6063939357;44792.55207448014;44894;45041.54958450374;46040;10101.24240681937;10154.39073655583;10311.020453056948;10660.413677247825;10900.890991090304;11262;11356.488957996744;11399.829002564802;11440.656780296604;11621;10118.949405252926;10186.796264074825;10238.846417303896;10257.692269231935;10370.066693997576;10311.639092631722;10316.948415257875;10359.378437293484;10532.473376331305;10829.404382759023;10145.492725363554;10269.486525673836;10293.176545876462;10423.322484038514;10605.787884242118;8680.869786953075;8797;8935.776605584912;9051.728448146567;9070.637174512945;8820.91179088201;9007.594658240527;9007.684731034644;9016.774580635274;9105.135012173832 07:13:36 INFO - PROCESS | 5228 | __end_tp_report 07:13:36 INFO - PROCESS | 5228 | __start_cc_report 07:13:36 INFO - PROCESS | 5228 | _x_x_mozilla_cycle_collect,1009 07:13:36 INFO - PROCESS | 5228 | __end_cc_report 07:13:36 INFO - PROCESS | 5228 | __startTimestamp1457277216413__endTimestamp 07:13:36 INFO - PROCESS | 5228 | 07:13:36 INFO - PROCESS | 5228 | ------- Summary: start ------- 07:13:36 INFO - PROCESS | 5228 | Number of tests: 6 07:13:36 INFO - PROCESS | 5228 | 07:13:36 INFO - PROCESS | 5228 | [#0] dojo.html Cycles:165 Average:5230.74 Median:5450.48 stddev:583.59 (10.7%) stddev-sans-first:562.80 07:13:36 INFO - PROCESS | 5228 | Values: 3181.4 3188.0 3230.7 3259.3 3290.3 5095.7 5167.6 5179.1 5215.1 5270.2 5208.6 5216.0 5251.6 5272.8 5316.4 4640.7 4737.0 4800.4 4873.8 4916.8 4671.4 4750.3 4854.2 4865.1 4970.0 4735.5 4738.9 4742.5 4743.0 4744.5 4735.9 4736.7 4747.9 4812.4 4834.6 4676.8 4684.4 4691.1 4713.4 4747.7 5086.2 5097.7 5103.0 5120.1 5153.9 5499.4 5574.0 5675.9 5725.2 5727.8 5643.7 5653.4 5666.1 5666.4 5667.4 5177.3 5215.5 5281.4 5283.6 5285.3 5719.3 5785.0 5789.7 5803.4 5826.0 5475.9 5510.5 5511.7 5513.1 5520.8 5502.1 5605.2 5616.5 5620.6 5643.2 5669.7 5670.9 5671.1 5671.9 5720.2 5643.9 5672.6 5673.3 5674.0 5676.1 4232.5 4250.7 4288.7 4303.7 4355.1 3851.7 3854.2 3857.5 3882.4 3888.7 5265.4 5269.2 5270.0 5272.2 5313.7 5591.4 5622.6 5643.4 5731.2 5739.6 5260.2 5277.8 5293.5 5295.4 5299.2 4787.1 4807.9 4808.5 4810.9 4852.9 5809.2 5809.4 5850.0 5908.8 5917.5 5588.7 5613.4 5618.5 5618.9 5630.3 5850.1 5893.1 5906.0 5908.1 5910.5 5547.8 5584.6 5587.9 5598.8 5629.5 5643.1 5661.1 5662.4 5666.3 5667.8 5407.9 5495.3 5495.5 5501.6 5507.2 5506.0 5517.7 5539.9 5547.3 5590.9 5412.9 5433.0 5450.4 5453.8 5454.2 5455.9 5531.4 5537.0 5548.4 5597.7 5337.8 5362.2 5415.7 5450.5 5465.3 07:13:36 INFO - PROCESS | 5228 | 07:13:36 INFO - PROCESS | 5228 | [#1] ext.html Cycles:180 Average:48193.99 Median:20737.54 stddev:85931.14 (414.4%) stddev-sans-first:86097.68 07:13:36 INFO - PROCESS | 5228 | Values: 530.0 538.9 541.3 543.4 559.5 28618.6 29139.3 37088.8 37273.4 37281.8 39414.2 39886.6 39906.6 39943.8 40104.0 8368.1 8554.8 8555.1 8563.0 8570.4 8599.6 8741.2 8756.8 8762.7 8770.5 8782.7 8863.1 8866.0 8867.1 8871.0 8661.3 8718.9 8724.0 8731.9 8739.8 8734.4 8847.3 8866.6 8871.9 8873.4 40024.2 40389.0 40504.0 40570.0 40637.6 3328.9 3453.6 3462.9 3612.7 3751.8 28776.6 30597.4 30901.4 31060.8 31185.4 3769.6 3777.7 3884.0 3981.3 3988.9 196642.0 197266.0 197469.0 197790.0 198218.0 59378.4 59961.7 59988.7 60321.1 60323.4 63417.0 65098.0 66597.3 66633.0 66724.0 15701.6 15880.0 15923.0 15936.8 15949.8 12127.1 12181.5 12200.3 12201.6 12202.6 20069.6 20359.0 20380.5 20411.6 20507.0 7985.5 8110.4 8147.6 8222.5 8240.8 945.2 960.7 983.6 1020.7 1046.5 28744.9 29050.1 29110.1 29582.9 29615.3 1065.4 1073.7 1073.8 1075.2 1086.8 14934.0 15107.6 15164.2 15348.1 15352.5 297901.0 468516.0 470281.0 471404.0 472908.0 51754.2 51928.2 52520.2 52550.2 52657.0 1290.8 1291.8 1330.8 1396.7 1506.7 27952.7 33019.3 33456.7 33512.8 33783.8 49913.0 50604.7 50853.5 50902.5 50936.0 285685.0 286740.0 287611.0 287910.0 289519.0 32181.5 42764.8 44349.6 44897.8 44975.6 40020.0 40094.8 40935.0 40996.6 41142.6 34330.7 34546.5 34650.7 34877.8 35029.3 34902.7 35072.8 35140.5 35471.6 35534.3 37468.4 37705.4 41499.2 42222.6 42993.0 31881.4 33256.2 33678.5 33716.8 33811.5 25695.0 26009.7 26319.2 26375.7 26536.6 07:13:36 INFO - PROCESS | 5228 | 07:13:36 INFO - PROCESS | 5228 | [#2] jquery.html Cycles:180 Average:24660.27 Median:363.09 stddev:70937.35 (19537.1%) stddev-sans-first:71112.85 07:13:36 INFO - PROCESS | 5228 | Values: 339.1 357.1 361.0 365.2 366.7 16656.7 17017.6 17549.8 18400.4 18827.1 11314.8 11622.5 11633.2 11638.5 16994.8 5055.5 5191.7 5215.9 5218.8 5418.7 5406.1 5447.3 5506.0 5524.2 5554.8 5346.2 5542.6 5546.0 5554.3 5555.6 5436.3 5450.9 5462.5 5462.5 5467.3 4898.8 4926.6 4931.8 4942.9 4950.1 19309.3 19671.4 20598.2 20609.5 20613.1 2011.1 2117.9 2265.8 2842.2 2873.6 9859.4 10219.4 10330.6 12609.1 13250.7 1814.5 1829.0 1850.6 1881.1 1884.7 59012.7 59350.7 59446.2 60555.1 61542.4 10291.8 10379.2 10435.9 10439.2 10552.4 13616.3 13748.9 13756.9 13766.4 13778.2 7493.7 7544.8 7553.2 7609.0 7629.5 7318.6 7399.7 7552.3 7647.5 7651.6 4399.8 4463.3 4465.3 4509.3 4607.8 1772.2 1823.6 1825.2 1844.5 1848.9 914.9 953.6 965.5 981.6 1023.2 16091.5 16599.7 16830.7 16898.2 17133.3 899.2 935.3 948.5 973.4 1008.9 9383.9 9547.9 9640.6 9644.7 9903.2 422504.0 434652.0 435123.0 438310.0 439088.0 47564.0 59544.1 60612.0 69688.0 70224.6 998.0 1021.7 1022.8 1036.2 1080.0 14675.9 14880.5 15010.7 15101.8 15330.5 31690.2 32636.2 32841.7 33243.0 34998.8 44875.0 47763.5 48131.3 48173.3 49049.5 7537.7 7741.6 7781.4 7785.9 7852.3 10181.3 11958.5 12076.9 12154.2 12349.3 10000.0 10174.8 10257.9 10318.2 10575.0 10198.0 10450.7 10594.9 10679.7 11059.3 10209.8 10477.8 10495.4 10581.3 10990.9 7822.8 7897.8 7990.4 8025.2 8038.0 8263.4 9593.3 10550.9 10726.9 10778.4 07:13:36 INFO - PROCESS | 5228 | 07:13:36 INFO - PROCESS | 5228 | [#3] mootools.html Cycles:180 Average:5504.19 Median:6358.99 stddev:2838.95 (44.6%) stddev-sans-first:2829.52 07:13:36 INFO - PROCESS | 5228 | Values: 1323.6 1481.9 1492.9 1676.1 1822.8 7253.3 7388.3 7397.3 7419.1 7459.2 7572.1 7730.3 7735.0 7737.3 7750.7 2068.7 2242.0 2277.9 2300.3 2341.3 2353.9 2362.5 2365.8 2367.0 2368.0 2294.9 2350.9 2354.1 2356.5 2361.8 2286.6 2295.4 2356.1 2356.7 2363.8 2327.5 2349.3 2360.3 2362.7 2386.0 7961.7 8024.5 8032.4 8037.2 8039.9 4902.5 4970.7 5001.9 5015.1 5016.1 3244.5 3356.3 3414.1 3427.9 3429.2 1067.5 1075.0 1084.1 1089.8 1090.5 11109.6 11160.3 11163.0 11189.4 11201.6 4523.7 4559.7 4637.9 4660.3 4678.2 9403.7 9407.2 9459.6 9504.3 9514.3 4333.7 5054.7 5055.6 5069.5 5074.0 3908.9 3960.0 4384.6 4493.4 4529.1 3753.6 3824.7 3831.9 3856.0 3875.1 1226.5 1238.1 1238.7 1249.5 1262.1 1335.1 1340.5 1359.1 1368.3 1381.1 7579.3 7689.3 7696.5 7707.2 7714.6 502.7 509.6 509.8 513.9 517.7 5342.3 5376.7 5383.4 5393.0 5410.5 8655.0 8720.2 8724.5 8849.2 9408.1 8725.5 8726.4 8822.5 8832.6 8847.7 7325.8 7359.9 7499.9 7501.3 7526.2 7441.3 7467.4 7483.7 7489.9 7567.1 8338.4 8598.6 8758.0 8857.6 8860.0 8711.6 8998.3 9085.4 9115.8 9169.6 6293.3 6644.3 6780.4 7231.3 7331.0 7154.8 7200.0 7208.1 7213.6 7227.3 6622.7 6709.8 6761.6 6821.1 6903.2 6776.1 6801.7 6856.2 6905.8 6928.9 6861.2 6991.1 7047.5 7091.3 7091.4 6521.9 6563.8 6607.9 6609.4 6613.2 6424.6 6429.0 6435.0 6437.1 6437.8 07:13:36 INFO - PROCESS | 5228 | 07:13:36 INFO - PROCESS | 5228 | [#4] prototype.html Cycles:180 Average:5243.74 Median:5928.88 stddev:1551.45 (26.2%) stddev-sans-first:1511.34 07:13:36 INFO - PROCESS | 5228 | Values: 330.1 333.8 336.5 336.7 341.3 5878.6 5904.2 5930.6 5936.4 5952.0 5858.0 5861.6 5863.4 5870.9 5873.1 4340.4 4473.0 4558.7 4607.4 4636.1 4602.4 4603.6 4607.4 4611.8 4615.7 4566.0 4574.1 4575.9 4579.2 4583.8 4356.6 4429.8 4509.2 4516.6 4522.5 3986.6 4006.1 4022.9 4024.6 4026.2 5610.8 5635.3 5640.9 5685.9 5686.2 5315.6 5318.2 5325.5 5325.6 5326.0 6244.0 6253.1 6253.8 6257.0 6257.7 4377.4 4399.9 4451.3 4453.8 4471.9 6459.4 6493.6 6497.3 6498.2 6515.7 4553.8 4555.7 4559.5 4559.7 4562.4 4606.3 4608.9 4611.3 4611.9 4615.1 5282.9 5286.5 5291.2 5291.8 5296.4 6124.6 6280.8 6292.5 6297.5 6298.4 1613.1 1631.7 1640.2 1640.9 1649.5 1036.7 1101.4 1101.8 1102.0 1136.1 5867.7 5918.2 5927.1 5940.8 5947.8 6384.3 6387.6 6394.7 6400.8 6401.3 5932.1 5936.5 5936.6 5939.7 5945.2 3416.0 3419.4 3448.6 3453.6 3459.6 6635.7 6687.1 6766.0 6777.7 6781.9 6469.6 6480.4 6513.3 6537.1 6557.9 6711.4 6721.7 6728.7 6737.4 6738.3 6323.9 6350.1 6368.6 6373.0 6385.0 6205.2 6350.7 6357.8 6364.1 6365.1 6716.8 6721.8 6745.4 6753.0 6758.7 4586.7 4589.2 4590.6 4595.9 4599.3 6371.3 6391.6 6405.5 6423.4 6473.3 6197.2 6212.1 6214.5 6215.6 6222.8 6053.8 6217.8 6224.5 6225.8 6227.7 6086.1 6089.1 6110.6 6118.9 6128.0 6181.8 6218.5 6219.7 6236.9 6241.9 5896.9 6034.3 6085.9 6100.7 6105.1 07:13:36 INFO - PROCESS | 5228 | 07:13:36 INFO - PROCESS | 5228 | [#5] yui.html Cycles:180 Average:13849.01 Median:48351.38 stddev:16546.74 (34.2%) stddev-sans-first:16563.30 07:13:36 INFO - PROCESS | 5228 | Values: 610.7 612.0 634.1 669.1 670.9 13665.0 13850.7 13856.9 13866.3 13885.3 14466.5 14681.8 14705.5 14762.1 14778.6 695.6 838.0 838.8 839.4 847.6 842.3 843.3 846.5 847.3 848.0 886.8 894.4 897.0 897.3 897.4 726.3 878.4 893.1 893.8 895.8 657.2 657.3 657.4 657.4 657.5 13746.0 13766.4 13801.2 13803.6 13805.0 12227.8 12354.4 12365.3 12743.3 12753.2 10210.0 10234.3 10348.0 10378.4 10488.9 3465.0 3497.9 3530.0 3592.4 3604.8 49618.5 49674.0 49894.0 49931.0 49999.5 9975.1 10001.0 10171.6 10207.8 10241.9 16838.3 16908.6 16932.2 16988.7 17006.4 7810.1 7832.8 7942.2 8018.5 8097.2 4211.8 4222.4 4257.7 4312.1 4315.4 3072.6 3073.6 3081.1 3089.0 3098.6 549.6 558.0 563.3 563.8 563.9 630.1 640.7 657.8 658.7 670.2 7773.3 7780.6 7821.9 7832.3 8043.1 472.0 539.8 558.0 568.7 576.4 3563.5 3627.6 3720.0 3764.5 3828.6 60461.0 60893.4 61384.0 61497.0 61545.4 50751.2 51889.2 51941.0 53166.0 53169.0 47520.8 49182.0 49603.5 50355.2 51147.2 8133.9 8326.0 8328.9 8412.3 8484.8 32669.2 32971.0 33487.3 33645.5 35651.3 39360.6 44792.6 44894.0 45041.5 46040.0 10101.2 10154.4 10311.0 10660.4 10900.9 11262.0 11356.5 11399.8 11440.7 11621.0 10118.9 10186.8 10238.8 10257.7 10370.1 10311.6 10316.9 10359.4 10532.5 10829.4 10145.5 10269.5 10293.2 10423.3 10605.8 8680.9 8797.0 8935.8 9051.7 9070.6 8820.9 9007.6 9007.7 9016.8 9105.1 07:13:36 INFO - PROCESS | 5228 | -------- Summary: end -------- 07:13:36 INFO - PROCESS | 5228 | 07:13:37 INFO - TEST-INFO | 5228: exit 0 07:13:37 INFO - TEST-OK | dromaeo_css | took 1113129ms 07:13:37 INFO - TEST-START | kraken 07:13:37 INFO - operating with platform_type : linux_ 07:13:37 INFO - Initialising browser for kraken test... 07:13:37 INFO - TEST-INFO | started process 5410 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKWpdh4/profile http://localhost:46601/getInfo.html) 07:13:41 INFO - PROCESS | 5410 | __metrics Screen width/height:1600/1200 07:13:41 INFO - PROCESS | 5410 | colorDepth:24 07:13:41 INFO - PROCESS | 5410 | Browser inner width/height: 1024/697 07:13:41 INFO - PROCESS | 5410 | __metrics 07:13:41 INFO - PROCESS | 5410 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:13:42 INFO - PROCESS | 5410 | 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. 07:13:42 INFO - TEST-INFO | 5410: exit 0 07:13:42 INFO - Browser initialized. 07:13:42 INFO - Running cycle 1/1 for kraken test... 07:13:42 INFO - TEST-INFO | started process 5492 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKWpdh4/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:13:54 INFO - PROCESS | 5492 | RSS: Main: 156631040 07:13:54 INFO - PROCESS | 5492 | 07:13:57 INFO - PROCESS | 5492 | Cycle 1(1): loaded http://localhost:46601/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46601/tests/kraken/driver.html?testName=audio-beat-detection) 07:13:57 INFO - PROCESS | 5492 | RSS: Main: 201617408 07:13:57 INFO - PROCESS | 5492 | 07:14:00 INFO - PROCESS | 5492 | Cycle 1(1): loaded http://localhost:46601/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46601/tests/kraken/driver.html?testName=audio-dft) 07:14:01 INFO - PROCESS | 5492 | RSS: Main: 190750720 07:14:01 INFO - PROCESS | 5492 | 07:14:03 INFO - PROCESS | 5492 | Cycle 1(1): loaded http://localhost:46601/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46601/tests/kraken/driver.html?testName=audio-fft) 07:14:04 INFO - PROCESS | 5492 | RSS: Main: 172453888 07:14:04 INFO - PROCESS | 5492 | 07:14:06 INFO - PROCESS | 5492 | Cycle 1(1): loaded http://localhost:46601/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46601/tests/kraken/driver.html?testName=audio-oscillator) 07:14:07 INFO - PROCESS | 5492 | RSS: Main: 174170112 07:14:07 INFO - PROCESS | 5492 | 07:14:09 INFO - PROCESS | 5492 | Cycle 1(1): loaded http://localhost:46601/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46601/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:14:09 INFO - PROCESS | 5492 | RSS: Main: 175575040 07:14:09 INFO - PROCESS | 5492 | 07:14:12 INFO - PROCESS | 5492 | Cycle 1(1): loaded http://localhost:46601/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46601/tests/kraken/driver.html?testName=imaging-darkroom) 07:14:13 INFO - PROCESS | 5492 | RSS: Main: 175685632 07:14:13 INFO - PROCESS | 5492 | 07:14:16 INFO - PROCESS | 5492 | Cycle 1(1): loaded http://localhost:46601/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46601/tests/kraken/driver.html?testName=imaging-desaturate) 07:14:17 INFO - PROCESS | 5492 | RSS: Main: 177692672 07:14:17 INFO - PROCESS | 5492 | 07:14:20 INFO - PROCESS | 5492 | Cycle 1(1): loaded http://localhost:46601/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46601/tests/kraken/driver.html?testName=json-parse-financial) 07:14:20 INFO - PROCESS | 5492 | RSS: Main: 177942528 07:14:20 INFO - PROCESS | 5492 | 07:14:22 INFO - PROCESS | 5492 | Cycle 1(1): loaded http://localhost:46601/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46601/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:14:23 INFO - PROCESS | 5492 | RSS: Main: 188891136 07:14:23 INFO - PROCESS | 5492 | 07:14:24 INFO - PROCESS | 5492 | Cycle 1(1): loaded http://localhost:46601/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46601/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:14:25 INFO - PROCESS | 5492 | RSS: Main: 184246272 07:14:25 INFO - PROCESS | 5492 | 07:14:27 INFO - PROCESS | 5492 | Cycle 1(1): loaded http://localhost:46601/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46601/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:14:28 INFO - PROCESS | 5492 | RSS: Main: 202629120 07:14:28 INFO - PROCESS | 5492 | 07:14:30 INFO - PROCESS | 5492 | Cycle 1(1): loaded http://localhost:46601/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46601/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:14:31 INFO - PROCESS | 5492 | RSS: Main: 205905920 07:14:31 INFO - PROCESS | 5492 | 07:14:33 INFO - PROCESS | 5492 | Cycle 1(1): loaded http://localhost:46601/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46601/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:14:34 INFO - PROCESS | 5492 | RSS: Main: 205570048 07:14:34 INFO - PROCESS | 5492 | 07:14:35 INFO - PROCESS | 5492 | Cycle 1(1): loaded http://localhost:46601/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46601/tests/kraken/driver.html?testName=ai-astar) 07:14:36 INFO - PROCESS | 5492 | RSS: Main: 264998912 07:14:36 INFO - PROCESS | 5492 | 07:14:36 INFO - PROCESS | 5492 | __start_tp_report 07:14:36 INFO - PROCESS | 5492 | _x_x_mozilla_page_load 07:14:36 INFO - PROCESS | 5492 | _x_x_mozilla_page_load_details 07:14:36 INFO - PROCESS | 5492 | |i|pagename|runs| 07:14:36 INFO - PROCESS | 5492 | |0;ai-astar;109;111;106;110;109;110;101;109;110;109 07:14:36 INFO - PROCESS | 5492 | |1;audio-beat-detection;151;129;149;168;126;159;152;129;177;127 07:14:36 INFO - PROCESS | 5492 | |2;audio-dft;162;163;161;161;163;165;161;163;162;161 07:14:36 INFO - PROCESS | 5492 | |3;audio-fft;73;75;99;100;74;73;75;119;95;75 07:14:36 INFO - PROCESS | 5492 | |4;audio-oscillator;94;94;152;93;93;94;145;93;93;132 07:14:36 INFO - PROCESS | 5492 | |5;imaging-gaussian-blur;117;117;117;117;117;116;116;116;116;116 07:14:36 INFO - PROCESS | 5492 | |6;imaging-darkroom;144;145;145;146;145;145;145;145;145;146 07:14:36 INFO - PROCESS | 5492 | |7;imaging-desaturate;95;96;96;96;96;96;96;96;95;95 07:14:36 INFO - PROCESS | 5492 | |8;json-parse-financial;57;56;57;56;56;56;56;65;54;53 07:14:36 INFO - PROCESS | 5492 | |9;json-stringify-tinderbox;67;67;68;67;67;68;69;67;67;67 07:14:36 INFO - PROCESS | 5492 | |10;stanford-crypto-aes;81;81;83;84;82;82;82;81;81;81 07:14:36 INFO - PROCESS | 5492 | |11;stanford-crypto-ccm;117;115;117;117;114;114;113;119;116;115 07:14:36 INFO - PROCESS | 5492 | |12;stanford-crypto-pbkdf2;148;144;147;150;148;143;157;144;162;151 07:14:36 INFO - PROCESS | 5492 | |13;stanford-crypto-sha256-iterative;68;71;69;68;68;67;68;68;67;66 07:14:36 INFO - PROCESS | 5492 | __end_tp_report 07:14:36 INFO - PROCESS | 5492 | __start_cc_report 07:14:36 INFO - PROCESS | 5492 | _x_x_mozilla_cycle_collect,1113 07:14:36 INFO - PROCESS | 5492 | __end_cc_report 07:14:36 INFO - PROCESS | 5492 | __startTimestamp1457277276181__endTimestamp 07:14:36 INFO - PROCESS | 5492 | 07:14:36 INFO - PROCESS | 5492 | ------- Summary: start ------- 07:14:36 INFO - PROCESS | 5492 | Number of tests: 14 07:14:36 INFO - PROCESS | 5492 | 07:14:36 INFO - PROCESS | 5492 | [#0] ai-astar Cycles:10 Average:108.40 Median:109.50 stddev:2.91 (2.7%) stddev-sans-first:3.08 07:14:36 INFO - PROCESS | 5492 | Values: 109.0 111.0 106.0 110.0 109.0 110.0 101.0 109.0 110.0 109.0 07:14:36 INFO - PROCESS | 5492 | 07:14:36 INFO - PROCESS | 5492 | [#1] audio-beat-detection Cycles:10 Average:146.70 Median:151.50 stddev:18.31 (12.1%) stddev-sans-first:19.36 07:14:36 INFO - PROCESS | 5492 | Values: 151.0 129.0 149.0 168.0 126.0 159.0 152.0 129.0 177.0 127.0 07:14:36 INFO - PROCESS | 5492 | 07:14:36 INFO - PROCESS | 5492 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.50 stddev:1.32 (0.8%) stddev-sans-first:1.39 07:14:36 INFO - PROCESS | 5492 | Values: 162.0 163.0 161.0 161.0 163.0 165.0 161.0 163.0 162.0 161.0 07:14:36 INFO - PROCESS | 5492 | 07:14:36 INFO - PROCESS | 5492 | [#3] audio-fft Cycles:10 Average:85.80 Median:75.00 stddev:16.26 (21.7%) stddev-sans-first:16.57 07:14:36 INFO - PROCESS | 5492 | Values: 73.0 75.0 99.0 100.0 74.0 73.0 75.0 119.0 95.0 75.0 07:14:36 INFO - PROCESS | 5492 | 07:14:36 INFO - PROCESS | 5492 | [#4] audio-oscillator Cycles:10 Average:108.30 Median:93.00 stddev:24.42 (26.3%) stddev-sans-first:25.35 07:14:36 INFO - PROCESS | 5492 | Values: 94.0 94.0 152.0 93.0 93.0 94.0 145.0 93.0 93.0 132.0 07:14:36 INFO - PROCESS | 5492 | 07:14:36 INFO - PROCESS | 5492 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 07:14:36 INFO - PROCESS | 5492 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 116.0 116.0 116.0 116.0 07:14:36 INFO - PROCESS | 5492 | 07:14:36 INFO - PROCESS | 5492 | [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.57 (0.4%) stddev-sans-first:0.44 07:14:36 INFO - PROCESS | 5492 | Values: 144.0 145.0 145.0 146.0 145.0 145.0 145.0 145.0 145.0 146.0 07:14:36 INFO - PROCESS | 5492 | 07:14:36 INFO - PROCESS | 5492 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 07:14:36 INFO - PROCESS | 5492 | Values: 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 95.0 07:14:36 INFO - PROCESS | 5492 | 07:14:36 INFO - PROCESS | 5492 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:56.00 stddev:3.20 (5.7%) stddev-sans-first:3.40 07:14:36 INFO - PROCESS | 5492 | Values: 57.0 56.0 57.0 56.0 56.0 56.0 56.0 65.0 54.0 53.0 07:14:36 INFO - PROCESS | 5492 | 07:14:36 INFO - PROCESS | 5492 | [#9] json-stringify-tinderbox Cycles:10 Average:67.40 Median:67.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 07:14:36 INFO - PROCESS | 5492 | Values: 67.0 67.0 68.0 67.0 67.0 68.0 69.0 67.0 67.0 67.0 07:14:36 INFO - PROCESS | 5492 | 07:14:36 INFO - PROCESS | 5492 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:82.00 stddev:1.03 (1.3%) stddev-sans-first:1.05 07:14:36 INFO - PROCESS | 5492 | Values: 81.0 81.0 83.0 84.0 82.0 82.0 82.0 81.0 81.0 81.0 07:14:36 INFO - PROCESS | 5492 | 07:14:36 INFO - PROCESS | 5492 | [#11] stanford-crypto-ccm Cycles:10 Average:115.70 Median:116.50 stddev:1.83 (1.6%) stddev-sans-first:1.88 07:14:36 INFO - PROCESS | 5492 | Values: 117.0 115.0 117.0 117.0 114.0 114.0 113.0 119.0 116.0 115.0 07:14:36 INFO - PROCESS | 5492 | 07:14:36 INFO - PROCESS | 5492 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.40 Median:149.00 stddev:6.04 (4.1%) stddev-sans-first:6.39 07:14:36 INFO - PROCESS | 5492 | Values: 148.0 144.0 147.0 150.0 148.0 143.0 157.0 144.0 162.0 151.0 07:14:36 INFO - PROCESS | 5492 | 07:14:36 INFO - PROCESS | 5492 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.00 stddev:1.33 (2.0%) stddev-sans-first:1.41 07:14:36 INFO - PROCESS | 5492 | Values: 68.0 71.0 69.0 68.0 68.0 67.0 68.0 68.0 67.0 66.0 07:14:36 INFO - PROCESS | 5492 | -------- Summary: end -------- 07:14:36 INFO - PROCESS | 5492 | 07:14:37 INFO - TEST-INFO | 5492: exit 0 07:14:37 INFO - TEST-OK | kraken | took 59972ms 07:14:37 INFO - SUITE-END | took 1173s 07:14:37 INFO - Completed test suite (00:19:33) 07:14:37 INFO - javascript benchmark 07:14:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3181.411438883805, 3187.9521807172896, 3230.741540676746, 3259.250372414345, 3290.341931613677, 5095.668781529198, 5167.612429067821, 5179.093658609742, 5215.061288967993, 5270.235815806705, 5208.583313334933, 5216.0, 5251.55361794248, 5272.789088436458, 5316.362036555609, 4640.698354606957, 4736.952630473695, 4800.447948485917, 4873.805047798084, 4916.778744956468, 4671.439427268732, 4750.311204875291, 4854.17479028566, 4865.075635629237, 4969.950300496985, 4735.479097299294, 4738.90522189556, 4742.549457801503, 4742.976285118552, 4744.549267819586, 4735.857924262277, 4736.739479328636, 4747.928781068286, 4812.422509298872, 4834.564889159958, 4676.766161691902, 4684.3910291662205, 4691.132140554008, 4713.410823647044, 4747.667663263573, 5086.160783470723, 5097.7196254206, 5102.974485127551, 5120.1039818031695, 5153.896922061575, 5499.367572729107, 5573.972130139364, 5675.858103547444, 5725.198472213893, 5727.828165155052, 5643.717814109278, 5653.378128405872, 5666.121751128581, 5666.376698563155, 5667.4049224831215, 5177.275181474596, 5215.530602245816, 5281.392639846428, 5283.577313814885, 5285.312909321802, 5719.28508936383, 5785.0, 5789.739461724233, 5803.361630220672, 5826.038703613941, 5475.8500714850325, 5510.476504732044, 5511.669299842022, 5513.062779327524, 5520.779168833282, 5502.0921547944145, 5605.215269862222, 5616.466435688603, 5620.57845661577, 5643.238162848045, 5669.744861481243, 5670.943290567042, 5671.092625179951, 5671.858203544862, 5720.170575266563, 5643.943560564342, 5672.574556908248, 5673.319201695823, 5674.0, 5676.0918253080135, 4232.534421213664, 4250.659947204216, 4288.742675439484, 4303.655707543389, 4355.063661312833, 3851.67260782831, 3854.171353159028, 3857.479240302523, 3882.4176373544196, 3888.650021498079, 5265.368155821249, 5269.209618557171, 5269.998700247017, 5272.182811664198, 5313.654612450178, 5591.3569939456665, 5622.550195984311, 5643.435656434323, 5731.197632331477, 5739.569532285095, 5260.158374660036, 5277.815276465382, 5293.497117773805, 5295.417504074549, 5299.152135658276, 4787.138315103315, 4807.855764327076, 4808.495108013678, 4810.903781924412, 4852.878678033077, 5809.24479817621, 5809.419058094157, 5849.970750146222, 5908.822735317862, 5917.52659787216, 5588.692621905834, 5613.382527922007, 5618.4662457066515, 5618.887622247614, 5630.296212973379, 5850.12248162779, 5893.116032595145, 5905.970470147622, 5908.05471124618, 5910.497607703222, 5547.833564993057, 5584.609077364546, 5587.888242235052, 5598.804041858515, 5629.4652008059165, 5643.125315575928, 5661.094224923992, 5662.377138514842, 5666.320041595035, 5667.801626943037, 5407.918881216706, 5495.313085864267, 5495.53287970527, 5501.559875209893, 5507.228987941771, 5506.0, 5517.69652669107, 5539.944600554104, 5547.306586676666, 5590.916136257878, 5412.891742165213, 5432.972835135799, 5450.400455949763, 5453.836384908459, 5454.209139674805, 5455.945440545703, 5531.363893152178, 5537.031019571639, 5548.361938377138, 5597.692126933058, 5337.839864804062, 5362.222477740784, 5415.729213539386, 5450.482204190595, 5465.344158700981], "unit": "score", "name": "dojo.html", "value": 5193.253131687051}, {"lowerIsBetter": false, "replicates": [529.9655522391042, 538.946359866461, 541.2638811216747, 543.3968295192336, 559.4880684173982, 28618.57072143917, 29139.27151821203, 37088.81455592718, 37273.44089838654, 37281.81359093208, 39414.21171576574, 39886.60113398865, 39906.600933990725, 39943.80168594947, 40104.0, 8368.079511253758, 8554.828903421927, 8555.058943516207, 8563.015253245863, 8570.357223208253, 8599.61301741423, 8741.213290803826, 8756.781080473007, 8762.737117886441, 8770.517621530813, 8782.692605758799, 8863.069377715343, 8865.95567022164, 8867.113288671146, 8871.024187339388, 8661.263792577638, 8718.912810871874, 8724.040355560883, 8731.869021964643, 8739.781505462352, 8734.432261903019, 8847.336449766293, 8866.556672166365, 8871.911280887238, 8873.423227490193, 40024.19951600952, 40389.0, 40504.0, 40570.0, 40637.59362406397, 3328.8834890778708, 3453.5510383649967, 3462.8961131166106, 3612.747107702462, 3751.7561358511884, 28776.568351474743, 30597.38805223883, 30901.38197236065, 31060.844695776603, 31185.37629247425, 3769.6418840210135, 3777.7355585109053, 3883.98058009711, 3981.2634662587516, 3988.880333589997, 196642.0, 197266.0, 197469.0, 197790.0, 198218.0, 59378.40621593815, 59961.70019149876, 59988.70005650031, 60321.09518357228, 60323.39676603265, 63417.0, 65098.0, 66597.33402666009, 66633.0, 66724.0, 15701.607459813597, 15880.0, 15923.044617322766, 15936.760948585781, 15949.760753588705, 12127.09046821492, 12181.512739490321, 12200.267983920992, 12201.633950981484, 12202.633920982385, 20069.59860802805, 20359.0, 20380.49048773763, 20411.59176816485, 20507.0, 7985.5208687478935, 8110.391720620859, 8147.551884646283, 8222.465539739898, 8240.83518329642, 945.2107490245585, 960.7406000379858, 983.5770618633914, 1020.6733845169623, 1046.49768111307, 28744.856275718488, 29050.128496144727, 29110.12669619915, 29582.852085739865, 29615.25961850971, 1065.387402243713, 1073.7208325835338, 1073.7530368015243, 1075.1613741281813, 1086.7772106718103, 14934.0, 15107.622309442351, 15164.241787910782, 15348.07911525312, 15352.462663806937, 297901.0, 468516.0, 470281.0, 471404.0, 472908.0, 51754.22368664473, 51928.22107668388, 52520.212196817076, 52550.21174682383, 52657.0, 1290.8192853000587, 1291.8126871603754, 1330.813686083949, 1396.7136736968896, 1506.6835964447368, 27952.720472795827, 33019.33961320808, 33456.665433345355, 33512.83243583766, 33783.83108084444, 49913.0, 50604.74697626635, 50853.49146508487, 50902.490975091256, 50935.999999998516, 285685.0, 286740.0, 287611.0, 287910.0, 289519.0, 32181.517277240393, 42764.78617607016, 44349.55650443454, 44897.775511122236, 44975.550244498445, 40020.0, 40094.799526002185, 40935.0, 40996.590034099274, 41142.58857411507, 34330.656693433746, 34546.481802772476, 34650.653493465754, 34877.8256108728, 35029.299414012086, 34902.650973490956, 35072.824635876656, 35140.47289290612, 35471.64528354786, 35534.28931421409, 37468.43797342988, 37705.43441848319, 41499.1700166001, 42222.553699283766, 42993.0, 31881.36237275288, 33256.1685957853, 33678.49482257817, 33716.83141584276, 33811.492827607115, 25695.0, 26009.739902600733, 26319.21042368732, 26375.736242638097, 26536.601950970366], "unit": "score", "name": "ext.html", "value": 18835.667706454602}, {"lowerIsBetter": false, "replicates": [339.141970813841, 357.0662716995059, 360.9909752256194, 365.1892797988465, 366.6993065686137, 16656.666866662676, 17017.574560635974, 17549.824501754996, 18400.35598754044, 18827.058647067624, 11314.830277545843, 11622.535098596047, 11633.185677002613, 11638.534458621645, 16994.83005169948, 5055.519725626069, 5191.688498690071, 5215.895682086356, 5218.843434696965, 5418.7019713915715, 5406.053940560386, 5447.346318441772, 5505.972470137664, 5524.226608274845, 5554.805581804638, 5346.198070289449, 5542.584306177053, 5546.029444847156, 5554.305711786027, 5555.583331250152, 5436.2661040759385, 5450.91823622646, 5462.453754624526, 5462.5083742462975, 5467.261919640838, 4898.755062246909, 4926.605871530305, 4931.80272789088, 4942.851714448572, 4950.059488697136, 19309.324173653855, 19671.426285897236, 20598.176072957063, 20609.484762880897, 20613.07241174151, 2011.145263263122, 2117.894105294729, 2265.76209498002, 2842.2183899427614, 2873.583330417078, 9859.408435493893, 10219.386836789816, 10330.638427654996, 12609.117361784678, 13250.734985300336, 1814.4738025972583, 1828.9634207315912, 1850.5743678953781, 1881.1158755385084, 1884.7267146263714, 59012.70493647547, 59350.70324648392, 59446.16369117521, 60555.09167362493, 61542.38457615456, 10291.794164116676, 10379.221558383151, 10435.94782026085, 10439.217058720475, 10552.41961692099, 13616.251106189255, 13748.93125534386, 13756.86243137576, 13766.449342026408, 13778.173309601456, 7493.700251989969, 7544.811379715441, 7553.169151393342, 7608.961955190189, 7629.465937384441, 7318.63406829667, 7399.741009064657, 7552.320291173821, 7647.502912310682, 7651.551503518821, 4399.84600538986, 4463.330500424962, 4465.307877279027, 4509.2559727644575, 4607.815687372535, 1772.2467951120723, 1823.626156637886, 1825.196913358118, 1844.5296449405585, 1848.9352872649392, 914.8764916736288, 953.5661274120258, 965.546193289167, 981.563204374061, 1023.155896385485, 16091.51725448215, 16599.6680066398, 16830.663386732198, 16898.155092245583, 17133.31466741341, 899.2311573604604, 935.2845073518764, 948.4925564822787, 973.3867663372172, 1008.8839783424853, 9383.906160938439, 9547.856782148274, 9640.614375424904, 9644.662436814679, 9903.207743380512, 422504.0, 434652.0, 435123.0, 438310.0, 439088.0, 47564.0, 59544.106838397456, 60612.0, 69688.0, 70224.6488767553, 997.9650712225038, 1021.7445638590352, 1022.8005538919839, 1036.1917704190744, 1079.9514021869036, 14675.853241467876, 14880.479183228535, 15010.699786004438, 15101.848981510484, 15330.463433779763, 31690.207744806565, 32636.184095397806, 32841.67158328482, 33243.0, 34998.82500587481, 44875.0, 47763.522364777295, 48131.27803083027, 48173.27740083831, 49049.509504905924, 7537.660805263886, 7741.5742134183165, 7781.416393770377, 7785.92214077852, 7852.254035866584, 10181.287309888237, 11958.461869215733, 12076.939615301868, 12154.209976351509, 12349.32078735678, 10000.0, 10174.796504069729, 10257.948710256402, 10318.226133040202, 10574.995375439321, 10198.031187037219, 10450.700845813908, 10594.947025264824, 10679.733006674895, 11059.281146725438, 10209.825870025043, 10477.842832357674, 10495.422751748421, 10581.259311848406, 10990.890091098987, 7822.765317040498, 7897.763067107996, 7990.360771138178, 8025.23760242776, 8038.0, 8263.421560490708, 9593.28050396237, 10550.89449105499, 10726.946365268124, 10778.353298801783], "unit": "score", "name": "jquery.html", "value": 8278.00650178844}, {"lowerIsBetter": false, "replicates": [1323.5963031275458, 1481.8518148185183, 1492.8656420922114, 1676.120036980585, 1822.835944764971, 7253.31093546113, 7388.335049845513, 7397.334239918413, 7419.146798118218, 7459.216782237868, 7572.12920514141, 7730.342920851735, 7735.0, 7737.342325902291, 7750.689972401097, 2068.7207227024387, 2241.9887900560475, 2277.886105694717, 2300.25241796416, 2341.262502311775, 2353.9411514712097, 2362.527494501098, 2365.8107351411845, 2367.029517897662, 2368.04094341791, 2294.850834695748, 2350.8589484630893, 2354.105439932832, 2356.45801465663, 2361.752016038317, 2286.634138537834, 2295.36877358726, 2356.092904231883, 2356.670066190735, 2363.83453158279, 2327.49958758866, 2349.3186975777003, 2360.3273067175774, 2362.7164740231283, 2385.988070059656, 7961.681532738684, 8024.518528888286, 8032.357411407073, 8037.23646253605, 8039.919600803975, 4902.509749025105, 4970.676906001098, 5001.874953126165, 5015.122353588144, 5016.07202667504, 3244.4971029490466, 3356.2616224430585, 3414.129397003773, 3427.8971630851115, 3429.176997520602, 1067.4609322292192, 1075.0, 1084.073117484555, 1089.7874914391696, 1090.547422819529, 11109.555617775279, 11160.330380177296, 11163.0, 11189.384583847885, 11201.607943722012, 4523.7285762854335, 4559.726416415026, 4637.8840528986375, 4660.277656963176, 4678.2280923647895, 9403.717888463358, 9407.2003879671, 9459.621615135455, 9504.287178461644, 9514.33399662031, 4333.71830830995, 5054.721990290569, 5055.595552355802, 5069.518395752398, 5073.9746301269, 3908.90227744303, 3959.9604003960167, 4384.56154384559, 4493.393391892118, 4529.071540334224, 3753.6434038766274, 3824.6557809796695, 3831.923361532754, 3855.9807200963814, 3875.050612599931, 1226.5400474821943, 1238.0900038471716, 1238.7089034076985, 1249.5314257153568, 1262.1165184370977, 1335.1121504199793, 1340.4705141469065, 1359.0622470495327, 1368.2953279061292, 1381.053978025056, 7579.317861392501, 7689.269519395649, 7696.538207707556, 7707.152213256537, 7714.5756983366455, 502.74108833950544, 509.59996402823606, 509.77824646278987, 513.8997895410433, 517.6893863681836, 5342.278792362981, 5376.704281264568, 5383.407825139231, 5392.973035134799, 5410.540104091117, 8655.047944726075, 8720.171583699539, 8724.520151391735, 8849.20357167858, 9408.106229908148, 8725.52009639476, 8726.389152759373, 8822.51476168804, 8832.64669413229, 8847.69033083839, 7325.7802265932105, 7359.852802943911, 7499.887501687479, 7501.287377699001, 7526.247375262539, 7441.293077157661, 7467.402607791255, 7483.663235154322, 7489.887651685338, 7567.129780075362, 8338.37462190326, 8598.570071496275, 8758.03661597211, 8857.64569417216, 8859.955700221457, 8711.607977640895, 8998.280137588847, 9085.364024518485, 9115.817683646157, 9169.587368568564, 6293.339199383999, 6644.269130395749, 6780.355866192704, 7231.3130252625915, 7330.973663686981, 7154.821129471805, 7199.964000179965, 7208.06295181623, 7213.639318033972, 7227.27727227273, 6622.668866556749, 6709.832254193684, 6761.560498567577, 6821.147356580427, 6903.1716194057035, 6776.119104516381, 6801.693923773541, 6856.24581296047, 6905.75829845953, 6928.896066558905, 6861.176658800976, 6991.056207412138, 7047.506674532939, 7091.326323999212, 7091.432685385053, 6521.902171467337, 6563.7702680405955, 6607.933920660732, 6609.405153536205, 6613.173353330833, 6424.646644434601, 6429.0, 6434.967825161031, 6437.0666253392055, 6437.839054023687], "unit": "score", "name": "mootools.html", "value": 4482.534725581838}, {"lowerIsBetter": false, "replicates": [330.14492464516894, 333.83975691668013, 336.4750988458005, 336.7003367003366, 341.3275846582234, 5878.617889837157, 5904.173415721797, 5930.614510056854, 5936.436038576334, 5951.970240148804, 5857.970710146444, 5861.560382971273, 5863.413658634135, 5870.853228669274, 5873.089671100986, 4340.43574335336, 4473.0, 4558.65519671696, 4607.447106347235, 4636.119137363907, 4602.424696912886, 4603.608693261077, 4607.447106347243, 4611.838585649503, 4615.653825963066, 4566.041131362418, 4574.130915126132, 4575.862724118282, 4579.175748365293, 4583.839565615204, 4356.629686476637, 4429.756363400012, 4509.233430316854, 4516.5935065843905, 4522.5025247222775, 3986.5614782373914, 4006.1186538961383, 4022.939655905164, 4024.557298697141, 4026.2350153470748, 5610.831675049755, 5635.267415236034, 5640.858978525529, 5685.943140568624, 5686.232358631573, 5315.6013299002725, 5318.228856815779, 5325.520703136697, 5325.600579956519, 5326.0, 6244.0, 6253.093301471306, 6253.843653908643, 6256.968715156395, 6257.749690012394, 4377.422848657415, 4399.868003959887, 4451.332300154971, 4453.755043472608, 4471.932921006188, 6459.386358295955, 6493.577917435352, 6497.317781632908, 6498.1552398188405, 6515.739370425177, 4553.840615578439, 4555.658325625592, 4559.52125026874, 4559.658025648089, 4562.361269422284, 4606.332081848113, 4608.907821843544, 4611.2852507861335, 4611.8847028823875, 4615.14619795339, 5282.920756188661, 5286.47135286476, 5291.232771248147, 5291.788328466818, 5296.443873393238, 6124.601900876429, 6280.842978925563, 6292.4966002719675, 6297.464715499143, 6298.370162983757, 1613.0886049382061, 1631.7307644238567, 1640.1717132848073, 1640.9097499637396, 1649.496903444437, 1036.6734478639205, 1101.4492753623188, 1101.8457415961773, 1101.9779604408027, 1136.091127098318, 5867.735951882176, 5918.201042859159, 5927.1405646181065, 5940.792072277536, 5947.791827286024, 6384.297727249998, 6387.616742995435, 6394.712237949303, 6400.807975760735, 6401.327860574573, 5932.0508718604815, 5936.5250779937505, 5936.554758393051, 5939.732712027969, 5945.1973983512535, 3415.9658403415647, 3419.3845107880325, 3448.620651728308, 3453.5510383649967, 3459.550258466383, 6635.668216589152, 6687.097241872382, 6766.0, 6777.661116944133, 6781.898271525931, 6469.5794773339585, 6480.351964803576, 6513.316101809337, 6537.052127441494, 6557.868842623217, 6711.429528490133, 6721.6975236114495, 6728.697208625624, 6737.3599508046655, 6738.258791532928, 6323.905141422974, 6350.142730731292, 6368.617882927039, 6373.0, 6385.042243663488, 6205.193324867739, 6350.68246587678, 6357.809265722036, 6364.140840986408, 6365.108884756045, 6716.83207919806, 6721.764738234138, 6745.426638735762, 6753.020811982334, 6758.695858686469, 4586.65600080002, 4589.173948689135, 4590.60979816706, 4595.885102872321, 4599.310103484504, 6371.331010243857, 6391.648459334781, 6405.455536279468, 6423.357664233539, 6473.320301368289, 6197.194364732556, 6212.099245609452, 6214.533909956681, 6215.595986260879, 6222.81331560054, 6053.788117415869, 6217.813465596039, 6224.470919971672, 6225.8132256032395, 6227.657478838707, 6086.056661217518, 6089.117078023751, 6110.602810817282, 6118.938810611837, 6127.969360153171, 6181.752729890754, 6218.471429928507, 6219.720112594853, 6236.906446403217, 6241.876462236841, 5896.941030589639, 6034.336223015553, 6085.878282434415, 6100.664463454553, 6105.145279660762], "unit": "score", "name": "prototype.html", "value": 4742.396192436121}, {"lowerIsBetter": false, "replicates": [610.7068607068604, 611.9785807496738, 634.0647544871315, 669.0633113640902, 670.8624731929955, 13665.0, 13850.722985540284, 13856.861431385683, 13866.306684665764, 13885.305734713262, 14466.493672721457, 14681.77977330341, 14705.485308014222, 14762.114273143592, 14778.630534236649, 695.6486974078083, 837.9916200837974, 838.7777239031661, 839.3956351426978, 847.5931552854634, 842.3261390887296, 843.2663582683043, 846.5386364431369, 847.3390755210945, 847.9745607631781, 886.7650072730731, 894.4275663575316, 897.0267260022883, 897.3404547657467, 897.3628723606247, 726.2700985509582, 878.44218920985, 893.1381217125505, 893.8033632600817, 895.8342706599235, 657.1719633262077, 657.3098246840798, 657.3656421553225, 657.4411750012499, 657.5265808617787, 13746.037777355588, 13766.449342026306, 13801.171929684251, 13803.585892423243, 13805.0, 12227.755444891141, 12354.444050017772, 12365.31990740509, 12743.299118548475, 12753.171043882117, 10210.0, 10234.283600147992, 10348.0, 10378.377297362182, 10488.895111048869, 3464.9653503465147, 3497.8600855965733, 3530.046887340404, 3592.4252119660728, 3604.8377822998027, 49618.50381496175, 49674.0, 49894.0, 49931.0, 49999.50000499985, 9975.057358079384, 10001.0, 10171.64399246023, 10207.846882296772, 10241.948790256001, 16838.326466941184, 16908.57728556796, 16932.153392330336, 16988.74516882248, 17006.404775832787, 7810.062792464941, 7832.804179895548, 7942.245486678757, 8018.51888886657, 8097.190280971973, 4211.831526738896, 4222.429971953747, 4257.680673949466, 4312.137572485515, 4315.395844581761, 3072.6466456357807, 3073.6465306489595, 3081.075677296802, 3089.0423968569366, 3098.612673415823, 549.5768258441058, 558.0206737176311, 563.3352643880179, 563.8252141836044, 563.8562166647561, 630.0958125090418, 640.6892657061321, 657.7829316325601, 658.716751796732, 670.1794911196276, 7773.261540153676, 7780.649870755717, 7821.882671759929, 7832.295093441618, 8043.075046369625, 471.9834805781781, 539.8245570189704, 557.9525740312118, 568.6900639151672, 576.3861487515783, 3563.483294922222, 3627.557477850944, 3719.962800372016, 3764.4541541476333, 3828.559715632738, 60461.0, 60893.39106608966, 61384.0, 61497.0, 61545.38454615397, 50751.23873141906, 51889.2216616751, 51941.0, 53166.0, 53169.0, 47520.7623961878, 49182.0, 49603.50396496061, 50355.24467132923, 51147.23279150741, 8133.877991830009, 8325.95837020811, 8328.875066874123, 8412.327013838756, 8484.830303394021, 32669.18327041843, 32971.0, 33487.330253394306, 33645.49531756977, 35651.28697425985, 39360.6063939357, 44792.55207448014, 44894.0, 45041.54958450374, 46040.0, 10101.24240681937, 10154.39073655583, 10311.020453056948, 10660.413677247825, 10900.890991090304, 11262.0, 11356.488957996744, 11399.829002564802, 11440.656780296604, 11621.0, 10118.949405252926, 10186.796264074825, 10238.846417303896, 10257.692269231935, 10370.066693997576, 10311.639092631722, 10316.948415257875, 10359.378437293484, 10532.473376331305, 10829.404382759023, 10145.492725363554, 10269.486525673836, 10293.176545876462, 10423.322484038514, 10605.787884242118, 8680.869786953075, 8797.0, 8935.776605584912, 9051.728448146567, 9070.637174512945, 8820.91179088201, 9007.594658240527, 9007.684731034644, 9016.774580635274, 9105.135012173832], "unit": "score", "name": "yui.html", "value": 6182.0064197370975}], "name": "dromaeo_css", "value": 6883.977220921227}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 111.0, 106.0, 110.0, 109.0, 110.0, 101.0, 109.0, 110.0, 109.0], "unit": "score", "name": "ai-astar", "value": 108.4}, {"lowerIsBetter": true, "replicates": [151.0, 129.0, 149.0, 168.0, 126.0, 159.0, 152.0, 129.0, 177.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 146.7}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 161.0, 161.0, 163.0, 165.0, 161.0, 163.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 162.2}, {"lowerIsBetter": true, "replicates": [73.0, 75.0, 99.0, 100.0, 74.0, 73.0, 75.0, 119.0, 95.0, 75.0], "unit": "score", "name": "audio-fft", "value": 85.8}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 152.0, 93.0, 93.0, 94.0, 145.0, 93.0, 93.0, 132.0], "unit": "score", "name": "audio-oscillator", "value": 108.3}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 116.0, 116.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.5}, {"lowerIsBetter": true, "replicates": [144.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.1}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 57.0, 56.0, 56.0, 56.0, 56.0, 65.0, 54.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.6}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 68.0, 67.0, 67.0, 68.0, 69.0, 67.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.4}, {"lowerIsBetter": true, "replicates": [81.0, 81.0, 83.0, 84.0, 82.0, 82.0, 82.0, 81.0, 81.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.8}, {"lowerIsBetter": true, "replicates": [117.0, 115.0, 117.0, 117.0, 114.0, 114.0, 113.0, 119.0, 116.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 115.7}, {"lowerIsBetter": true, "replicates": [148.0, 144.0, 147.0, 150.0, 148.0, 143.0, 157.0, 144.0, 162.0, 151.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.4}, {"lowerIsBetter": true, "replicates": [68.0, 71.0, 69.0, 68.0, 68.0, 67.0, 68.0, 68.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.0}], "name": "kraken", "value": 1507.6000000000001}]} 07:14:37 INFO - Return code: 0 07:14:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 07:14:37 INFO - # TBPL SUCCESS # 07:14:37 INFO - Running post-action listener: _resource_record_post_action 07:14:37 INFO - Running post-run listener: _resource_record_post_run 07:14:38 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 536924160; Read time: 16; Write time: 506652 07:14:38 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 240852992; Read time: 0; Write time: 262816 07:14:38 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 296071168; Read time: 16; Write time: 243836 07:14:38 INFO - Running post-run listener: _upload_blobber_files 07:14:38 INFO - Blob upload gear active. 07:14:38 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 07:14:38 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:14:38 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'] 07:14:38 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 07:14:38 INFO - (blobuploader) - INFO - Open directory for files ... 07:14:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:14:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:14:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:14:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:14:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:14:39 INFO - (blobuploader) - INFO - Done attempting. 07:14:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 07:14:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:14:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:14:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:14:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:14:40 INFO - (blobuploader) - INFO - Done attempting. 07:14:40 INFO - (blobuploader) - INFO - Iteration through files over. 07:14:40 INFO - Return code: 0 07:14:40 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 07:14:40 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 07:14:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/251618e2bb5e645561a1d1dca139eab2a625b70fc0ccbcb9871fcfca96659e71a5b0b44d15b9cc1eb99bb8c6a8f2a93705ad11690a84fd3019179a008dda83a6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/584aa38252b9a581c34db52ce11d133a09414e4e637734108479b396d6ef4e403cf6810b949ebedc2120c8ce568e8bbeacc327544ba0e8475146151164949424"} 07:14:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 07:14:40 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 07:14:40 INFO - Contents: 07:14:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/251618e2bb5e645561a1d1dca139eab2a625b70fc0ccbcb9871fcfca96659e71a5b0b44d15b9cc1eb99bb8c6a8f2a93705ad11690a84fd3019179a008dda83a6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/584aa38252b9a581c34db52ce11d133a09414e4e637734108479b396d6ef4e403cf6810b949ebedc2120c8ce568e8bbeacc327544ba0e8475146151164949424"} 07:14:40 INFO - Running post-run listener: copy_logs_to_upload_dir 07:14:40 INFO - Copying logs to upload dir... 07:14:40 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 07:14:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.634165 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-03-06 07:14:40.240171) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-06 07:14:40.243335) ========= 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=0333a256a5e4f052382dd180000001b1-1457273634.917430-1353739975 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/251618e2bb5e645561a1d1dca139eab2a625b70fc0ccbcb9871fcfca96659e71a5b0b44d15b9cc1eb99bb8c6a8f2a93705ad11690a84fd3019179a008dda83a6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/584aa38252b9a581c34db52ce11d133a09414e4e637734108479b396d6ef4e403cf6810b949ebedc2120c8ce568e8bbeacc327544ba0e8475146151164949424"} build_url:https://queue.taskcluster.net/v1/task/B8rXrdc_TV-X2rzihdjt2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011273 build_url: 'https://queue.taskcluster.net/v1/task/B8rXrdc_TV-X2rzihdjt2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/251618e2bb5e645561a1d1dca139eab2a625b70fc0ccbcb9871fcfca96659e71a5b0b44d15b9cc1eb99bb8c6a8f2a93705ad11690a84fd3019179a008dda83a6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/584aa38252b9a581c34db52ce11d133a09414e4e637734108479b396d6ef4e403cf6810b949ebedc2120c8ce568e8bbeacc327544ba0e8475146151164949424"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-06 07:14:40.267358) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 07:14:40.267657) ========= 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=0333a256a5e4f052382dd180000001b1-1457273634.917430-1353739975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004502 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 07:14:40.351591) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-06 07:14:40.351902) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-06 07:14:40.352191) ========= ========= Total master_lag: 0.36 =========