builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-003 starttime: 1455125143.16 results: success (0) buildid: 20160210043003 builduid: d500ce8630c2470e9e87228db5aa6f89 revision: 7042e8a19f94d6e075ec149567aea74dfd06c392 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-10 09:25:43.158678) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-10 09:25:43.159114) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-10 09:25:43.159418) ========= 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=7de08804244eb36560b44971000001c3-1455125142.48559-1281864518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005682 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-10 09:25:43.179696) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-10 09:25:43.180105) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-10 09:25:43.190732) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 09:25:43.191014) ========= 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=7de08804244eb36560b44971000001c3-1455125142.48559-1281864518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004625 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 09:25:43.240088) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-10 09:25:43.240408) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-10 09:25:43.240778) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 09:25:43.241054) ========= 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=7de08804244eb36560b44971000001c3-1455125142.48559-1281864518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-10 09:25:43-- 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% 43.6M=0s 2016-02-10 09:25:43 (43.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.159451 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 09:25:43.412678) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 09:25:43.412991) ========= 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=7de08804244eb36560b44971000001c3-1455125142.48559-1281864518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022222 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 09:25:43.462420) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 09:25:43.462770) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7042e8a19f94d6e075ec149567aea74dfd06c392 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 7042e8a19f94d6e075ec149567aea74dfd06c392 --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=7de08804244eb36560b44971000001c3-1455125142.48559-1281864518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-10 09:25:43,663 truncating revision to first 12 chars 2016-02-10 09:25:43,663 Setting DEBUG logging. 2016-02-10 09:25:43,663 attempt 1/10 2016-02-10 09:25:43,663 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7042e8a19f94?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-10 09:25:43,931 unpacking tar archive at: mozilla-central-7042e8a19f94/testing/mozharness/ program finished with exit code 0 elapsedTime=0.538247 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 09:25:44.014076) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-10 09:25:44.014500) ========= echo 7042e8a19f94d6e075ec149567aea74dfd06c392 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'7042e8a19f94d6e075ec149567aea74dfd06c392'] 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=7de08804244eb36560b44971000001c3-1455125142.48559-1281864518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 7042e8a19f94d6e075ec149567aea74dfd06c392 program finished with exit code 0 elapsedTime=0.004146 script_repo_revision: '7042e8a19f94d6e075ec149567aea74dfd06c392' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-10 09:25:44.064179) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-10 09:25:44.064518) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-10 09:25:44.074285) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-02-10 09:25:44.074666) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7de08804244eb36560b44971000001c3-1455125142.48559-1281864518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:25:44 INFO - MultiFileLogger online at 20160210 09:25:44 in /builds/slave/test-pgo 09:25:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 09:25:44 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 09:25:44 INFO - {'append_to_log': False, 09:25:44 INFO - 'base_work_dir': '/builds/slave/test-pgo', 09:25:44 INFO - 'blob_upload_branch': 'Firefox', 09:25:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 09:25:44 INFO - 'branch': 'Firefox', 09:25:44 INFO - 'buildbot_json_path': 'buildprops.json', 09:25:44 INFO - 'config_files': ('talos/linux_config.py',), 09:25:44 INFO - 'default_actions': ('clobber', 09:25:44 INFO - 'read-buildbot-config', 09:25:44 INFO - 'download-and-extract', 09:25:44 INFO - 'populate-webroot', 09:25:44 INFO - 'create-virtualenv', 09:25:44 INFO - 'install', 09:25:44 INFO - 'run-tests'), 09:25:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:25:44 INFO - 'download_minidump_stackwalk': True, 09:25:44 INFO - 'download_symbols': 'ondemand', 09:25:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:25:44 INFO - 'tooltool.py': '/tools/tooltool.py', 09:25:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:25:44 INFO - '/tools/misc-python/virtualenv.py')}, 09:25:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:25:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:25:44 INFO - 'installer_path': 'installer.exe', 09:25:44 INFO - 'log_level': 'info', 09:25:44 INFO - 'log_name': 'talos', 09:25:44 INFO - 'log_to_console': True, 09:25:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:25:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:25:44 INFO - 'opt_config_files': (), 09:25:44 INFO - 'pip_index': False, 09:25:44 INFO - 'sps_profile': False, 09:25:44 INFO - 'sps_profile_interval': 0, 09:25:44 INFO - 'suite': 'dromaeojs', 09:25:44 INFO - 'system_bits': '32', 09:25:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:25:44 INFO - 'title': 'talos-linux64-ix-003', 09:25:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:25:44 INFO - 'use_talos_json': True, 09:25:44 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 09:25:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:25:44 INFO - 'work_dir': 'build'} 09:25:44 INFO - ##### 09:25:44 INFO - ##### Running clobber step. 09:25:44 INFO - ##### 09:25:44 INFO - Running pre-action listener: _resource_record_pre_action 09:25:44 INFO - Running main action method: clobber 09:25:44 INFO - rmtree: /builds/slave/test-pgo/build 09:25:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 09:25:45 INFO - Running post-action listener: _resource_record_post_action 09:25:45 INFO - ##### 09:25:45 INFO - ##### Running read-buildbot-config step. 09:25:45 INFO - ##### 09:25:45 INFO - Running pre-action listener: _resource_record_pre_action 09:25:45 INFO - Running main action method: read_buildbot_config 09:25:45 INFO - Using buildbot properties: 09:25:45 INFO - { 09:25:45 INFO - "project": "", 09:25:45 INFO - "product": "firefox", 09:25:45 INFO - "script_repo_revision": "production", 09:25:45 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 09:25:45 INFO - "repository": "", 09:25:45 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 09:25:45 INFO - "buildid": "20160210043003", 09:25:45 INFO - "pgo_build": "True", 09:25:45 INFO - "basedir": "/builds/slave/test-pgo", 09:25:45 INFO - "buildnumber": 665, 09:25:45 INFO - "slavename": "talos-linux64-ix-003", 09:25:45 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:25:45 INFO - "platform": "ubuntu64_hw", 09:25:45 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 09:25:45 INFO - "branch": "mozilla-central", 09:25:45 INFO - "repo_path": "mozilla-central", 09:25:45 INFO - "revision": "7042e8a19f94d6e075ec149567aea74dfd06c392", 09:25:45 INFO - "stage_platform": "linux64-pgo", 09:25:45 INFO - "builduid": "d500ce8630c2470e9e87228db5aa6f89", 09:25:45 INFO - "slavebuilddir": "test" 09:25:45 INFO - } 09:25:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/bUm4NeltToSNRHrl6TZdUQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 09:25:45 INFO - Running post-action listener: _resource_record_post_action 09:25:45 INFO - ##### 09:25:45 INFO - ##### Running download-and-extract step. 09:25:45 INFO - ##### 09:25:45 INFO - Running pre-action listener: _resource_record_pre_action 09:25:45 INFO - Running main action method: download_and_extract 09:25:45 INFO - mkdir: /builds/slave/test-pgo/build/tests 09:25:45 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')]} 09:25:45 INFO - https://queue.taskcluster.net/v1/task/bUm4NeltToSNRHrl6TZdUQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:25:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bUm4NeltToSNRHrl6TZdUQ/artifacts/public/build/test_packages.json 09:25:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bUm4NeltToSNRHrl6TZdUQ/artifacts/public/build/test_packages.json 09:25:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bUm4NeltToSNRHrl6TZdUQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 09:25:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bUm4NeltToSNRHrl6TZdUQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 09:25:45 INFO - Downloaded 1448 bytes. 09:25:45 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 09:25:45 INFO - Using the following test package requirements: 09:25:45 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 09:25:45 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:25:45 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:25:45 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:25:45 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:25:45 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:25:45 INFO - u'jsshell-linux-x86_64.zip'], 09:25:45 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:25:45 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:25:45 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 09:25:45 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:25:45 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:25:45 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:25:45 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:25:45 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:25:45 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:25:45 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 09:25:45 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:25:45 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:25:45 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:25:45 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')]} 09:25:45 INFO - https://queue.taskcluster.net/v1/task/bUm4NeltToSNRHrl6TZdUQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:25:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bUm4NeltToSNRHrl6TZdUQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 09:25:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bUm4NeltToSNRHrl6TZdUQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 09:25:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bUm4NeltToSNRHrl6TZdUQ/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 09:25:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bUm4NeltToSNRHrl6TZdUQ/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 09:25:46 INFO - Downloaded 23293211 bytes. 09:25:46 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'] 09:25:46 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 09:25:48 INFO - Return code: 0 09:25:48 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 09:25:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:25:48 INFO - https://queue.taskcluster.net/v1/task/bUm4NeltToSNRHrl6TZdUQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:25:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bUm4NeltToSNRHrl6TZdUQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 09:25:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bUm4NeltToSNRHrl6TZdUQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 09:25:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bUm4NeltToSNRHrl6TZdUQ/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 09:25:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bUm4NeltToSNRHrl6TZdUQ/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 09:25:49 INFO - Downloaded 23293211 bytes. 09:25:49 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'] 09:25:49 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 09:25:50 INFO - Return code: 0 09:25:50 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')]} 09:25:50 INFO - https://queue.taskcluster.net/v1/task/bUm4NeltToSNRHrl6TZdUQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:25:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bUm4NeltToSNRHrl6TZdUQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 09:25:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bUm4NeltToSNRHrl6TZdUQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 09:25:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bUm4NeltToSNRHrl6TZdUQ/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 09:25:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bUm4NeltToSNRHrl6TZdUQ/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 09:25:51 INFO - Downloaded 10706547 bytes. 09:25:51 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'] 09:25:51 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 09:25:51 INFO - Return code: 0 09:25:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:25:51 INFO - https://queue.taskcluster.net/v1/task/bUm4NeltToSNRHrl6TZdUQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:25:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bUm4NeltToSNRHrl6TZdUQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 09:25:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bUm4NeltToSNRHrl6TZdUQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 09:25:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bUm4NeltToSNRHrl6TZdUQ/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 09:25:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bUm4NeltToSNRHrl6TZdUQ/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 09:25:53 INFO - Downloaded 56564385 bytes. 09:25:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bUm4NeltToSNRHrl6TZdUQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 09:25:53 INFO - mkdir: /builds/slave/test-pgo/properties 09:25:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 09:25:53 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 09:25:53 INFO - Contents: 09:25:53 INFO - build_url:https://queue.taskcluster.net/v1/task/bUm4NeltToSNRHrl6TZdUQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 09:25:54 INFO - Running post-action listener: _resource_record_post_action 09:25:54 INFO - Running post-action listener: set_extra_try_arguments 09:25:54 INFO - ##### 09:25:54 INFO - ##### Running populate-webroot step. 09:25:54 INFO - ##### 09:25:54 INFO - Running pre-action listener: _resource_record_pre_action 09:25:54 INFO - Running main action method: populate_webroot 09:25:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:25:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:25:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:25:54 INFO - '--tppagecycles', 09:25:54 INFO - '7'], 09:25:54 INFO - 'tests': ['tsvgm']}}, 09:25:54 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:25:54 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:25:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:25:54 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:25:54 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:25:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:25:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:25:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:54 INFO - 'talos_options': ['--e10s'], 09:25:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:25:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:54 INFO - 'tests': ['damp', 'tps']}, 09:25:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:54 INFO - 'talos_options': ['--e10s'], 09:25:54 INFO - 'tests': ['damp', 'tps']}, 09:25:54 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:25:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:25:54 INFO - 'other': {'tests': ['a11yr', 09:25:54 INFO - 'ts_paint', 09:25:54 INFO - 'tpaint', 09:25:54 INFO - 'sessionrestore', 09:25:54 INFO - 'sessionrestore_no_auto_restore']}, 09:25:54 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:25:54 INFO - 'tests': ['a11yr', 09:25:54 INFO - 'ts_paint', 09:25:54 INFO - 'tpaint', 09:25:54 INFO - 'sessionrestore', 09:25:54 INFO - 'sessionrestore_no_auto_restore']}, 09:25:54 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:25:54 INFO - 'tests': ['a11yr', 09:25:54 INFO - 'ts_paint', 09:25:54 INFO - 'tpaint', 09:25:54 INFO - 'sessionrestore', 09:25:54 INFO - 'sessionrestore_no_auto_restore']}, 09:25:54 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:25:54 INFO - 'tests': ['a11yr', 09:25:54 INFO - 'ts_paint', 09:25:54 INFO - 'tpaint', 09:25:54 INFO - 'sessionrestore', 09:25:54 INFO - 'sessionrestore_no_auto_restore']}, 09:25:54 INFO - 'other_l64': {'tests': ['a11yr', 09:25:54 INFO - 'ts_paint', 09:25:54 INFO - 'tpaint', 09:25:54 INFO - 'sessionrestore', 09:25:54 INFO - 'sessionrestore_no_auto_restore']}, 09:25:54 INFO - 'other_nol64': {'tests': ['a11yr', 09:25:54 INFO - 'ts_paint', 09:25:54 INFO - 'tpaint', 09:25:54 INFO - 'sessionrestore', 09:25:54 INFO - 'sessionrestore_no_auto_restore']}, 09:25:54 INFO - 'svgr': {'tests': ['tsvgx', 09:25:54 INFO - 'tsvgr_opacity', 09:25:54 INFO - 'tart', 09:25:54 INFO - 'tscrollx', 09:25:54 INFO - 'cart']}, 09:25:54 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:25:54 INFO - 'tests': ['tsvgx', 09:25:54 INFO - 'tsvgr_opacity', 09:25:54 INFO - 'tart', 09:25:54 INFO - 'tscrollx', 09:25:54 INFO - 'cart']}, 09:25:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:54 INFO - 'tests': ['tp5o']}, 09:25:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:54 INFO - 'talos_options': ['--e10s'], 09:25:54 INFO - 'tests': ['tp5o']}, 09:25:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:54 INFO - 'talos_options': ['--xperf_path', 09:25:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:25:54 INFO - 'tests': ['tp5n']}, 09:25:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:54 INFO - 'talos_options': ['--e10s', 09:25:54 INFO - '--xperf_path', 09:25:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:25:54 INFO - 'tests': ['tp5n']}}, 09:25:54 INFO - 'talos.zip': {'path': '', 09:25:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:25:54 INFO - Running post-action listener: _resource_record_post_action 09:25:54 INFO - ##### 09:25:54 INFO - ##### Running create-virtualenv step. 09:25:54 INFO - ##### 09:25:54 INFO - Running pre-action listener: _resource_record_pre_action 09:25:54 INFO - Running main action method: create_virtualenv 09:25:54 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 09:25:54 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 09:25:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 09:25:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:25:54 INFO - Using real prefix '/usr' 09:25:54 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 09:25:55 INFO - Installing distribute.............................................................................................................................................................................................done. 09:25:57 INFO - Installing pip.................done. 09:25:57 INFO - Return code: 0 09:25:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 09:25:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:25:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0abe77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x125e670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ed8c0>, '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 0x12ee7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12eec50>, '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': '7de08804244eb36560b44971000001c3-1455125142.48559-1281864518', '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 09:25:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 09:25:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:25:57 INFO - Using env: {'DISPLAY': ':0', 09:25:57 INFO - 'HOME': '/home/cltbld', 09:25:57 INFO - 'LANG': 'en_US.UTF-8', 09:25:57 INFO - 'LANGUAGE': 'en_US:en', 09:25:57 INFO - 'LOGNAME': 'cltbld', 09:25:57 INFO - 'MAIL': '/var/mail/cltbld', 09:25:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:57 INFO - 'MOZ_NO_REMOTE': '1', 09:25:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:57 INFO - 'NO_EM_RESTART': '1', 09:25:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:25:57 INFO - 'PWD': '/builds/slave/test-pgo', 09:25:57 INFO - 'SHELL': '/bin/bash', 09:25:57 INFO - 'SHLVL': '1', 09:25:57 INFO - 'TERM': 'linux', 09:25:57 INFO - 'TMOUT': '86400', 09:25:57 INFO - 'USER': 'cltbld', 09:25:57 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1455125142.48559-1281864518', 09:25:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:57 INFO - '_': '/tools/buildbot/bin/python'} 09:25:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:57 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 09:25:57 INFO - Cleaning up... 09:25:57 INFO - Return code: 0 09:25:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 09:25:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:25:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe0abe77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x125e670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ed8c0>, '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 0x12ee7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12eec50>, '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': '7de08804244eb36560b44971000001c3-1455125142.48559-1281864518', '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 09:25:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 09:25:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:25:57 INFO - Using env: {'DISPLAY': ':0', 09:25:57 INFO - 'HOME': '/home/cltbld', 09:25:57 INFO - 'LANG': 'en_US.UTF-8', 09:25:57 INFO - 'LANGUAGE': 'en_US:en', 09:25:57 INFO - 'LOGNAME': 'cltbld', 09:25:57 INFO - 'MAIL': '/var/mail/cltbld', 09:25:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:57 INFO - 'MOZ_NO_REMOTE': '1', 09:25:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:57 INFO - 'NO_EM_RESTART': '1', 09:25:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:25:57 INFO - 'PWD': '/builds/slave/test-pgo', 09:25:57 INFO - 'SHELL': '/bin/bash', 09:25:57 INFO - 'SHLVL': '1', 09:25:57 INFO - 'TERM': 'linux', 09:25:57 INFO - 'TMOUT': '86400', 09:25:57 INFO - 'USER': 'cltbld', 09:25:57 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1455125142.48559-1281864518', 09:25:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:57 INFO - '_': '/tools/buildbot/bin/python'} 09:25:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:57 INFO - Downloading/unpacking psutil>=0.7.1 09:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 09:25:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:25:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:25:59 INFO - Installing collected packages: psutil 09:25:59 INFO - Running setup.py install for psutil 09:25:59 INFO - building 'psutil._psutil_linux' extension 09:25:59 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 09:25:59 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 09:25:59 INFO - building 'psutil._psutil_posix' extension 09:25:59 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 09:25:59 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 09:25:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:25:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:25:59 INFO - Successfully installed psutil 09:25:59 INFO - Cleaning up... 09:25:59 INFO - Return code: 0 09:25:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 09:25:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:25:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:25:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe0abe77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x125e670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ed8c0>, '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 0x12ee7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12eec50>, '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': '7de08804244eb36560b44971000001c3-1455125142.48559-1281864518', '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 09:25:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 09:25:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:25:59 INFO - Using env: {'DISPLAY': ':0', 09:25:59 INFO - 'HOME': '/home/cltbld', 09:25:59 INFO - 'LANG': 'en_US.UTF-8', 09:25:59 INFO - 'LANGUAGE': 'en_US:en', 09:25:59 INFO - 'LOGNAME': 'cltbld', 09:25:59 INFO - 'MAIL': '/var/mail/cltbld', 09:25:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:59 INFO - 'MOZ_NO_REMOTE': '1', 09:25:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:59 INFO - 'NO_EM_RESTART': '1', 09:25:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:25:59 INFO - 'PWD': '/builds/slave/test-pgo', 09:25:59 INFO - 'SHELL': '/bin/bash', 09:25:59 INFO - 'SHLVL': '1', 09:25:59 INFO - 'TERM': 'linux', 09:25:59 INFO - 'TMOUT': '86400', 09:25:59 INFO - 'USER': 'cltbld', 09:25:59 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1455125142.48559-1281864518', 09:25:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:59 INFO - '_': '/tools/buildbot/bin/python'} 09:26:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:26:00 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 09:26:00 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 09:26:00 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 09:26:00 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 09:26:00 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 09:26:00 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 09:26:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:26:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:26:01 INFO - Installing collected packages: mozsystemmonitor 09:26:01 INFO - Running setup.py install for mozsystemmonitor 09:26:01 INFO - Successfully installed mozsystemmonitor 09:26:01 INFO - Cleaning up... 09:26:02 INFO - Return code: 0 09:26:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 09:26: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')]} 09:26:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26: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')]} 09:26:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:02 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 0x7fe0abe77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x125e670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ed8c0>, '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 0x12ee7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12eec50>, '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': '7de08804244eb36560b44971000001c3-1455125142.48559-1281864518', '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 09:26:02 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 09:26:02 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 09:26:02 INFO - Using env: {'DISPLAY': ':0', 09:26:02 INFO - 'HOME': '/home/cltbld', 09:26:02 INFO - 'LANG': 'en_US.UTF-8', 09:26:02 INFO - 'LANGUAGE': 'en_US:en', 09:26:02 INFO - 'LOGNAME': 'cltbld', 09:26:02 INFO - 'MAIL': '/var/mail/cltbld', 09:26:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:02 INFO - 'MOZ_NO_REMOTE': '1', 09:26:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:26:02 INFO - 'NO_EM_RESTART': '1', 09:26:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:26:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:26:02 INFO - 'PWD': '/builds/slave/test-pgo', 09:26:02 INFO - 'SHELL': '/bin/bash', 09:26:02 INFO - 'SHLVL': '1', 09:26:02 INFO - 'TERM': 'linux', 09:26:02 INFO - 'TMOUT': '86400', 09:26:02 INFO - 'USER': 'cltbld', 09:26:02 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1455125142.48559-1281864518', 09:26:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:02 INFO - '_': '/tools/buildbot/bin/python'} 09:26:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:02 INFO - Downloading/unpacking blobuploader==1.2.4 09:26:02 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 09:26:02 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 09:26:02 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 09:26:02 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 09:26:02 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 09:26:02 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 09:26:04 INFO - Downloading blobuploader-1.2.4.tar.gz 09:26:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:26:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:26:04 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 09:26:04 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 09:26:04 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 09:26:04 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 09:26:04 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 09:26:04 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 09:26:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 09:26:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:26:04 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 09:26:04 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 09:26:04 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 09:26:04 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 09:26:04 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 09:26:04 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 09:26:04 INFO - Downloading docopt-0.6.1.tar.gz 09:26:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 09:26:04 INFO - Installing collected packages: blobuploader, requests, docopt 09:26:04 INFO - Running setup.py install for blobuploader 09:26:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:26:04 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 09:26:04 INFO - Running setup.py install for requests 09:26:05 INFO - Running setup.py install for docopt 09:26:05 INFO - Successfully installed blobuploader requests docopt 09:26:05 INFO - Cleaning up... 09:26:05 INFO - Return code: 0 09:26:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:26:05 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')]} 09:26:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:05 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')]} 09:26:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:05 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 0x7fe0abe77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x125e670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ed8c0>, '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 0x12ee7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12eec50>, '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': '7de08804244eb36560b44971000001c3-1455125142.48559-1281864518', '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 09:26:05 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 09:26:05 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 09:26:05 INFO - Using env: {'DISPLAY': ':0', 09:26:05 INFO - 'HOME': '/home/cltbld', 09:26:05 INFO - 'LANG': 'en_US.UTF-8', 09:26:05 INFO - 'LANGUAGE': 'en_US:en', 09:26:05 INFO - 'LOGNAME': 'cltbld', 09:26:05 INFO - 'MAIL': '/var/mail/cltbld', 09:26:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:05 INFO - 'MOZ_NO_REMOTE': '1', 09:26:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:26:05 INFO - 'NO_EM_RESTART': '1', 09:26:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:26:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:26:05 INFO - 'PWD': '/builds/slave/test-pgo', 09:26:05 INFO - 'SHELL': '/bin/bash', 09:26:05 INFO - 'SHLVL': '1', 09:26:05 INFO - 'TERM': 'linux', 09:26:05 INFO - 'TMOUT': '86400', 09:26:05 INFO - 'USER': 'cltbld', 09:26:05 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1455125142.48559-1281864518', 09:26:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:05 INFO - '_': '/tools/buildbot/bin/python'} 09:26:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:26:05 INFO - Running setup.py (path:/tmp/pip-QCF7PT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:26:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:26:05 INFO - Running setup.py (path:/tmp/pip-KNg0Ns-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:26:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:26:05 INFO - Running setup.py (path:/tmp/pip-Sjnumd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:26:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:26:05 INFO - Running setup.py (path:/tmp/pip-Mbxxfj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:26:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:26:05 INFO - Running setup.py (path:/tmp/pip-NYe67Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:26:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:26:05 INFO - Running setup.py (path:/tmp/pip-bBJXHo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:26:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:26:06 INFO - Running setup.py (path:/tmp/pip-_M0CTQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:26:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:26:06 INFO - Running setup.py (path:/tmp/pip-7nC7i8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:26:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:26:06 INFO - Running setup.py (path:/tmp/pip-pOQIB3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:26:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:26:06 INFO - Running setup.py (path:/tmp/pip-UYqyJQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:26:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:26:06 INFO - Running setup.py (path:/tmp/pip-JRI1_J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:26:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:26:06 INFO - Running setup.py (path:/tmp/pip-APkBzB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:26:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:26:06 INFO - Running setup.py (path:/tmp/pip-EHWB1s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:26:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:26:06 INFO - Running setup.py (path:/tmp/pip-6n8UEv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:26:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:26:06 INFO - Running setup.py (path:/tmp/pip-fStHUk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:26:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:26:06 INFO - Running setup.py (path:/tmp/pip-jVOQUR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:26:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:26:06 INFO - Running setup.py (path:/tmp/pip-r8rptl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:26:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:26:06 INFO - Running setup.py install for manifestparser 09:26:06 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 09:26:06 INFO - Running setup.py install for mozcrash 09:26:06 INFO - Running setup.py install for mozdebug 09:26:07 INFO - Running setup.py install for mozdevice 09:26:07 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 09:26:07 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 09:26:07 INFO - Running setup.py install for mozfile 09:26:07 INFO - Running setup.py install for mozhttpd 09:26:07 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 09:26:07 INFO - Running setup.py install for mozinfo 09:26:07 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 09:26:07 INFO - Running setup.py install for mozInstall 09:26:07 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 09:26:07 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 09:26:07 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 09:26:07 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 09:26:07 INFO - Running setup.py install for mozleak 09:26:07 INFO - Running setup.py install for mozlog 09:26:07 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 09:26:07 INFO - Running setup.py install for moznetwork 09:26:07 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 09:26:07 INFO - Running setup.py install for mozprocess 09:26:08 INFO - Running setup.py install for mozprofile 09:26:08 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 09:26:08 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 09:26:08 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 09:26:08 INFO - Running setup.py install for mozrunner 09:26:08 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 09:26:08 INFO - Running setup.py install for mozscreenshot 09:26:08 INFO - Running setup.py install for moztest 09:26:08 INFO - Running setup.py install for mozversion 09:26:08 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 09:26:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:26:08 INFO - Cleaning up... 09:26:08 INFO - Return code: 0 09:26:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:26:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:26:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:26:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:08 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 0x7fe0abe77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x125e670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ed8c0>, '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 0x12ee7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12eec50>, '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': '7de08804244eb36560b44971000001c3-1455125142.48559-1281864518', '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 09:26:08 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 09:26:08 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 09:26:08 INFO - Using env: {'DISPLAY': ':0', 09:26:08 INFO - 'HOME': '/home/cltbld', 09:26:08 INFO - 'LANG': 'en_US.UTF-8', 09:26:08 INFO - 'LANGUAGE': 'en_US:en', 09:26:08 INFO - 'LOGNAME': 'cltbld', 09:26:08 INFO - 'MAIL': '/var/mail/cltbld', 09:26:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:08 INFO - 'MOZ_NO_REMOTE': '1', 09:26:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:26:08 INFO - 'NO_EM_RESTART': '1', 09:26:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:26:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:26:08 INFO - 'PWD': '/builds/slave/test-pgo', 09:26:08 INFO - 'SHELL': '/bin/bash', 09:26:08 INFO - 'SHLVL': '1', 09:26:08 INFO - 'TERM': 'linux', 09:26:08 INFO - 'TMOUT': '86400', 09:26:08 INFO - 'USER': 'cltbld', 09:26:08 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1455125142.48559-1281864518', 09:26:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:08 INFO - '_': '/tools/buildbot/bin/python'} 09:26:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:26:08 INFO - Running setup.py (path:/tmp/pip-pm9Puw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:26:08 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)) 09:26:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:26:08 INFO - Running setup.py (path:/tmp/pip-f1by8v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:26:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 09:26:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:26:08 INFO - Running setup.py (path:/tmp/pip-Iwr86v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:26:09 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)) 09:26:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:26:09 INFO - Running setup.py (path:/tmp/pip-wuY4Ka-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:26:09 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)) 09:26:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:26:09 INFO - Running setup.py (path:/tmp/pip-6Vhzcf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:26:09 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)) 09:26:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:26:09 INFO - Running setup.py (path:/tmp/pip-LnJ8v0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:26:09 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)) 09:26:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:26:09 INFO - Running setup.py (path:/tmp/pip-34_aoK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:26:09 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)) 09:26:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:26:09 INFO - Running setup.py (path:/tmp/pip-pCnymB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:26:09 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)) 09:26:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:26:09 INFO - Running setup.py (path:/tmp/pip-ppvtPa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:26:09 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)) 09:26:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:26:09 INFO - Running setup.py (path:/tmp/pip-bq8Rnp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:26:09 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)) 09:26:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:26:09 INFO - Running setup.py (path:/tmp/pip-15ybl0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:26:09 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)) 09:26:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:26:09 INFO - Running setup.py (path:/tmp/pip-edIIA9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:26:09 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)) 09:26:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:26:09 INFO - Running setup.py (path:/tmp/pip-aOdadU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:26:09 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)) 09:26:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:26:09 INFO - Running setup.py (path:/tmp/pip-HJLiOi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:26:09 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)) 09:26:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:26:09 INFO - Running setup.py (path:/tmp/pip-EQr6y7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:26:09 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)) 09:26:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:26:09 INFO - Running setup.py (path:/tmp/pip-0KbOqZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:26:09 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)) 09:26:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:26:09 INFO - Running setup.py (path:/tmp/pip-9ZWQF7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:26:10 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)) 09:26:10 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.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 09:26:10 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.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 09:26:10 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)) 09:26:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 09:26:10 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)) 09:26:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:26:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:11 INFO - Downloading blessings-1.6.tar.gz 09:26:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 09:26:11 INFO - Installing collected packages: blessings 09:26:11 INFO - Running setup.py install for blessings 09:26:11 INFO - Successfully installed blessings 09:26:11 INFO - Cleaning up... 09:26:12 INFO - Return code: 0 09:26:12 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 09:26:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:26:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:26:12 INFO - Reading from file tmpfile_stdout 09:26:12 INFO - Current package versions: 09:26:12 INFO - argparse == 1.2.1 09:26:12 INFO - blessings == 1.6 09:26:12 INFO - blobuploader == 1.2.4 09:26:12 INFO - docopt == 0.6.1 09:26:12 INFO - manifestparser == 1.1 09:26:12 INFO - mozInstall == 1.12 09:26:12 INFO - mozcrash == 0.16 09:26:12 INFO - mozdebug == 0.1 09:26:12 INFO - mozdevice == 0.48 09:26:12 INFO - mozfile == 1.2 09:26:12 INFO - mozhttpd == 0.7 09:26:12 INFO - mozinfo == 0.9 09:26:12 INFO - mozleak == 0.1 09:26:12 INFO - mozlog == 3.1 09:26:12 INFO - moznetwork == 0.27 09:26:12 INFO - mozprocess == 0.22 09:26:12 INFO - mozprofile == 0.28 09:26:12 INFO - mozrunner == 6.11 09:26:12 INFO - mozscreenshot == 0.1 09:26:12 INFO - mozsystemmonitor == 0.0 09:26:12 INFO - moztest == 0.7 09:26:12 INFO - mozversion == 1.4 09:26:12 INFO - psutil == 3.1.1 09:26:12 INFO - requests == 1.2.3 09:26:12 INFO - wsgiref == 0.1.2 09:26:12 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:26:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:26:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:26:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:12 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 0x7fe0abe77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x125e670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ed8c0>, '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 0x12ee7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12eec50>, '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': '7de08804244eb36560b44971000001c3-1455125142.48559-1281864518', '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 09:26:12 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 09:26:12 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 09:26:12 INFO - Using env: {'DISPLAY': ':0', 09:26:12 INFO - 'HOME': '/home/cltbld', 09:26:12 INFO - 'LANG': 'en_US.UTF-8', 09:26:12 INFO - 'LANGUAGE': 'en_US:en', 09:26:12 INFO - 'LOGNAME': 'cltbld', 09:26:12 INFO - 'MAIL': '/var/mail/cltbld', 09:26:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:12 INFO - 'MOZ_NO_REMOTE': '1', 09:26:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:26:12 INFO - 'NO_EM_RESTART': '1', 09:26:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:26:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:26:12 INFO - 'PWD': '/builds/slave/test-pgo', 09:26:12 INFO - 'SHELL': '/bin/bash', 09:26:12 INFO - 'SHLVL': '1', 09:26:12 INFO - 'TERM': 'linux', 09:26:12 INFO - 'TMOUT': '86400', 09:26:12 INFO - 'USER': 'cltbld', 09:26:12 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1455125142.48559-1281864518', 09:26:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:12 INFO - '_': '/tools/buildbot/bin/python'} 09:26:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:12 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)) 09:26:12 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)) 09:26:12 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)) 09:26:12 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)) 09:26:12 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)) 09:26:12 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)) 09:26:12 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)) 09:26:12 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)) 09:26:12 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)) 09:26:12 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)) 09:26:12 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)) 09:26:12 INFO - Cleaning up... 09:26:12 INFO - Return code: 0 09:26:12 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 09:26:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:26:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:26:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:12 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0abe77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x125e670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ed8c0>, '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 0x12ee7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12eec50>, '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': '7de08804244eb36560b44971000001c3-1455125142.48559-1281864518', '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 09:26:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 09:26:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:26:12 INFO - Using env: {'DISPLAY': ':0', 09:26:12 INFO - 'HOME': '/home/cltbld', 09:26:12 INFO - 'LANG': 'en_US.UTF-8', 09:26:12 INFO - 'LANGUAGE': 'en_US:en', 09:26:12 INFO - 'LOGNAME': 'cltbld', 09:26:12 INFO - 'MAIL': '/var/mail/cltbld', 09:26:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:12 INFO - 'MOZ_NO_REMOTE': '1', 09:26:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:26:12 INFO - 'NO_EM_RESTART': '1', 09:26:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:26:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:26:12 INFO - 'PWD': '/builds/slave/test-pgo', 09:26:12 INFO - 'SHELL': '/bin/bash', 09:26:12 INFO - 'SHLVL': '1', 09:26:12 INFO - 'TERM': 'linux', 09:26:12 INFO - 'TMOUT': '86400', 09:26:12 INFO - 'USER': 'cltbld', 09:26:12 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1455125142.48559-1281864518', 09:26:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:12 INFO - '_': '/tools/buildbot/bin/python'} 09:26:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:12 INFO - Downloading/unpacking jsonschema 09:26:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:26:14 INFO - Downloading/unpacking functools32 (from jsonschema) 09:26:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:14 INFO - Downloading functools32-3.2.3-2.tar.gz 09:26:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 09:26:14 INFO - warning: no files found matching '*.txt' 09:26:14 INFO - no previously-included directories found matching 'build' 09:26:14 INFO - no previously-included directories found matching 'dist' 09:26:14 INFO - no previously-included directories found matching '.git*' 09:26:14 INFO - Installing collected packages: jsonschema, functools32 09:26:14 INFO - Running setup.py install for functools32 09:26:14 INFO - warning: no files found matching '*.txt' 09:26:14 INFO - no previously-included directories found matching 'build' 09:26:14 INFO - no previously-included directories found matching 'dist' 09:26:14 INFO - no previously-included directories found matching '.git*' 09:26:14 INFO - Successfully installed jsonschema functools32 09:26:14 INFO - Cleaning up... 09:26:14 INFO - Return code: 0 09:26:14 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 09:26:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:26:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:26:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:14 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0abe77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x125e670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ed8c0>, '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 0x12ee7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12eec50>, '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': '7de08804244eb36560b44971000001c3-1455125142.48559-1281864518', '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 09:26:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 09:26:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:26:14 INFO - Using env: {'DISPLAY': ':0', 09:26:14 INFO - 'HOME': '/home/cltbld', 09:26:14 INFO - 'LANG': 'en_US.UTF-8', 09:26:14 INFO - 'LANGUAGE': 'en_US:en', 09:26:14 INFO - 'LOGNAME': 'cltbld', 09:26:14 INFO - 'MAIL': '/var/mail/cltbld', 09:26:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:14 INFO - 'MOZ_NO_REMOTE': '1', 09:26:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:26:14 INFO - 'NO_EM_RESTART': '1', 09:26:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:26:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:26:14 INFO - 'PWD': '/builds/slave/test-pgo', 09:26:14 INFO - 'SHELL': '/bin/bash', 09:26:14 INFO - 'SHLVL': '1', 09:26:14 INFO - 'TERM': 'linux', 09:26:14 INFO - 'TMOUT': '86400', 09:26:14 INFO - 'USER': 'cltbld', 09:26:14 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1455125142.48559-1281864518', 09:26:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:14 INFO - '_': '/tools/buildbot/bin/python'} 09:26:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:15 INFO - Downloading/unpacking flake8 09:26:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:26:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:26:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:26:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:26:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:26:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 09:26:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:26:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:26:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:26:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:26:17 INFO - no previously-included directories found matching 'docs/_build' 09:26:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:26:17 INFO - Running setup.py install for pep8 09:26:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:26:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:26:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:26:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:26:17 INFO - no previously-included directories found matching 'docs/_build' 09:26:17 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 09:26:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:26:17 INFO - Cleaning up... 09:26:17 INFO - Return code: 0 09:26:17 INFO - Running post-action listener: _resource_record_post_action 09:26:17 INFO - Running post-action listener: _start_resource_monitoring 09:26:17 INFO - Starting resource monitoring. 09:26:17 INFO - ##### 09:26:17 INFO - ##### Running install step. 09:26:17 INFO - ##### 09:26:17 INFO - Running pre-action listener: _resource_record_pre_action 09:26:17 INFO - Running main action method: install 09:26:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:26:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:26:18 INFO - Reading from file tmpfile_stdout 09:26:18 INFO - Detecting whether we're running mozinstall >=1.0... 09:26:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 09:26:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 09:26:18 INFO - Reading from file tmpfile_stdout 09:26:18 INFO - Output received: 09:26:18 INFO - Usage: mozinstall [options] installer 09:26:18 INFO - Options: 09:26:18 INFO - -h, --help show this help message and exit 09:26:18 INFO - -d DEST, --destination=DEST 09:26:18 INFO - Directory to install application into. [default: 09:26:18 INFO - "/builds/slave/test-pgo"] 09:26:18 INFO - --app=APP Application being installed. [default: firefox] 09:26:18 INFO - mkdir: /builds/slave/test-pgo/build/application 09:26:18 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'] 09:26:18 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 09:26:34 INFO - Reading from file tmpfile_stdout 09:26:34 INFO - Output received: 09:26:34 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 09:26:34 INFO - Running post-action listener: _resource_record_post_action 09:26:34 INFO - ##### 09:26:34 INFO - ##### Running run-tests step. 09:26:34 INFO - ##### 09:26:34 INFO - Running pre-action listener: _resource_record_pre_action 09:26:34 INFO - Running main action method: run_tests 09:26:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 09:26:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 09:26:34 INFO - Python 2.7.3 09:26:34 INFO - Return code: 0 09:26:34 INFO - grabbing minidump binary from tooltool 09:26:34 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')]} 09:26:34 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 0x12ed8c0>, '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 0x12ee7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12eec50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 09:26:34 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 09:26:34 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 09:26:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:26:34 INFO - Return code: 0 09:26:34 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 09:26:34 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 09:26:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 09:26:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 09:26:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 09:26:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 09:26:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 09:26:35 INFO - Return code: 0 09:26:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bUm4NeltToSNRHrl6TZdUQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 09:26:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bUm4NeltToSNRHrl6TZdUQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --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 09:26:35 INFO - Using env: {'DISPLAY': ':0', 09:26:35 INFO - 'HOME': '/home/cltbld', 09:26:35 INFO - 'LANG': 'en_US.UTF-8', 09:26:35 INFO - 'LANGUAGE': 'en_US:en', 09:26:35 INFO - 'LOGNAME': 'cltbld', 09:26:35 INFO - 'MAIL': '/var/mail/cltbld', 09:26:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:26:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 09:26:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:35 INFO - 'MOZ_NO_REMOTE': '1', 09:26:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:26:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:26:35 INFO - 'NO_EM_RESTART': '1', 09:26:35 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:26:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:26:35 INFO - 'PWD': '/builds/slave/test-pgo', 09:26:35 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 09:26:35 INFO - 'SHELL': '/bin/bash', 09:26:35 INFO - 'SHLVL': '1', 09:26:35 INFO - 'TERM': 'linux', 09:26:35 INFO - 'TMOUT': '86400', 09:26:35 INFO - 'USER': 'cltbld', 09:26:35 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1455125142.48559-1281864518', 09:26:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:35 INFO - '_': '/tools/buildbot/bin/python'} 09:26:35 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bUm4NeltToSNRHrl6TZdUQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 09:26:35 INFO - mozversion application_buildid: 20160210043003 09:26:35 INFO - mozversion application_changeset: 7042e8a19f94d6e075ec149567aea74dfd06c392 09:26:35 INFO - mozversion application_display_name: Nightly 09:26:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:26:35 INFO - mozversion application_name: Firefox 09:26:35 INFO - mozversion application_remotingname: firefox 09:26:35 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:26:35 INFO - mozversion application_vendor: Mozilla 09:26:35 INFO - mozversion application_version: 47.0a1 09:26:35 INFO - mozversion platform_buildid: 20160210043003 09:26:35 INFO - mozversion platform_changeset: 7042e8a19f94d6e075ec149567aea74dfd06c392 09:26:35 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:26:35 INFO - mozversion platform_version: 47.0a1 09:26:35 INFO - using testdate: 1455125195 09:26:35 INFO - actual date: 1455125195 09:26:35 INFO - starting webserver on 'localhost:33604' 09:26:35 INFO - SUITE-START | Running 2 tests 09:26:35 INFO - TEST-START | dromaeo_css 09:26:35 INFO - operating with platform_type : linux_ 09:26:35 INFO - Initialising browser for dromaeo_css test... 09:26:35 INFO - TEST-INFO | started process 13357 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpttapG0/profile http://localhost:33604/getInfo.html) 09:26:39 INFO - PROCESS | 13357 | __metrics Screen width/height:1600/1200 09:26:39 INFO - PROCESS | 13357 | colorDepth:24 09:26:39 INFO - PROCESS | 13357 | Browser inner width/height: 1024/697 09:26:39 INFO - PROCESS | 13357 | __metrics 09:26:39 INFO - PROCESS | 13357 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:26:40 INFO - TEST-INFO | 13357: exit 0 09:26:40 INFO - Browser initialized. 09:26:40 INFO - Running cycle 1/1 for dromaeo_css test... 09:26:40 INFO - TEST-INFO | started process 13450 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpttapG0/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:26:52 INFO - PROCESS | 13450 | RSS: Main: 153354240 09:26:52 INFO - PROCESS | 13450 | 09:27:44 INFO - PROCESS | 13450 | 1455125264082 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] 09:29:52 INFO - PROCESS | 13450 | Cycle 1(1): loaded http://localhost:33604/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33604/tests/dromaeo/cssquery-ext.html) 09:29:53 INFO - PROCESS | 13450 | RSS: Main: 265707520 09:29:53 INFO - PROCESS | 13450 | 09:32:55 INFO - PROCESS | 13450 | Cycle 1(1): loaded http://localhost:33604/tests/dromaeo/cssquery-ext.html (next: http://localhost:33604/tests/dromaeo/cssquery-jquery.html) 09:32:56 INFO - PROCESS | 13450 | RSS: Main: 237391872 09:32:56 INFO - PROCESS | 13450 | 09:35:58 INFO - PROCESS | 13450 | Cycle 1(1): loaded http://localhost:33604/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33604/tests/dromaeo/cssquery-mootools.html) 09:35:58 INFO - PROCESS | 13450 | RSS: Main: 221917184 09:35:58 INFO - PROCESS | 13450 | 09:39:00 INFO - PROCESS | 13450 | Cycle 1(1): loaded http://localhost:33604/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33604/tests/dromaeo/cssquery-prototype.html) 09:39:01 INFO - PROCESS | 13450 | RSS: Main: 214872064 09:39:01 INFO - PROCESS | 13450 | 09:42:03 INFO - PROCESS | 13450 | Cycle 1(1): loaded http://localhost:33604/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33604/tests/dromaeo/cssquery-yui.html) 09:42:04 INFO - PROCESS | 13450 | RSS: Main: 216756224 09:42:04 INFO - PROCESS | 13450 | 09:45:07 INFO - PROCESS | 13450 | Cycle 1(1): loaded http://localhost:33604/tests/dromaeo/cssquery-yui.html (next: http://localhost:33604/tests/dromaeo/cssquery-dojo.html) 09:45:07 INFO - PROCESS | 13450 | RSS: Main: 258609152 09:45:07 INFO - PROCESS | 13450 | 09:45:07 INFO - PROCESS | 13450 | __start_tp_report 09:45:07 INFO - PROCESS | 13450 | _x_x_mozilla_page_load 09:45:07 INFO - PROCESS | 13450 | _x_x_mozilla_page_load_details 09:45:07 INFO - PROCESS | 13450 | |i|pagename|runs| 09:45:07 INFO - PROCESS | 13450 | |0;dojo.html;3144.654088050314;3175.1744546417926;3213.3733921885228;3213.453712868812;3252.0894149638093;4846.4911184325665;5055.873603159927;5067.6452648314635;5114.232865070241;5165.173572228439;4994.525520075596;5044.747762611873;5046.268291097788;5061.898762024757;5073.873153171173;4546.772661366935;4651.511591282909;4721.386219791422;4751.453582837966;4836.250381190904;4594.264917613183;4654.6974446661025;4745.644076694244;4753.3582966299455;4813.927791083137;4618.722876627413;4646.279826626845;4647.23320652092;4672.9953060092075;4702.670813043088;4634.3048542718525;4647.3958385410015;4670.182718024366;4690.812367505296;4737.028909073631;4587.541245875419;4641.234196357597;4649.488556258809;4652.62778977681;4665.206914824488;4795.088933102699;4807.855764327076;4817.975910120427;4821.0357928414105;4988.55103040728;5404.189371594253;5408.4591540845995;5410.91883621746;5411.540019098381;5438.293021907127;5410.594205434569;5418.431064738224;5418.674879507203;5427.050266203399;5427.674339539641;5127.282180494733;5128.153854613947;5130.820421285237;5201.635885487979;5204.609654275944;5624.409437009137;5636.154576813511;5650.067738823048;5721.313442386941;5721.713914304268;5390.54180394663;5392.973035134799;5422.6475279106735;5433.510984011379;5434.755436005389;5376.569874410116;5469.097598896137;5483.424240454695;5513.5037846594;5554.277943867352;5456.345238571397;5513.2005859151;5515.090010148361;5555.861103472364;5566.304211973504;5507.504324610804;5534.501894829405;5537.501624853782;5537.916931246034;5538.75075621598;4179.519355274182;4313.935290970638;4317.6114149726045;4326.091520780608;4364.519902810688;3824.8852534424013;3841.5582208045876;3860.536735591747;3866;3882.3400021996326;4989.276554899519;5003.074431230234;5007.974960125176;5032.245163225545;5052.520010598987;5287.07476191665;5310.575153987672;5357.5446087082255;5357.955198736287;5399.947010332948;5086.796528138907;5099.643024988215;5103.97448012765;5140.56305214061;5179.948200517946;4591.655625828076;4610.654200934943;4616.907661846812;4639.884002899887;4679.22792739201;5554.055810512223;5573.637713548606;5622.128570071563;5624.915626265528;5633.915491267634;5526.861828454321;5530.529904957963;5556.194351819045;5562.249096371938;5603.159526071122;5605.327360716577;5605.355384130714;5605.4114317997655;5611;5612.382637909745;5363.946360536344;5373.596980226577;5401.864953376197;5446.319210098738;5475.233467314659;5497.47773961473;5505.889882202254;5506.752196151103;5508.14623733322;5509.393966663583;5321.840344789663;5339.065663508793;5368.114261146867;5369.328833895763;5417.945820541744;5188.9740551297;5260.86847828792;5349.598780091431;5350.384705758887;5422.996745602076;5253.448387919213;5268.104422248303;5293.100172970681;5297.894042119213;5300.761465734128;5386.057439947915;5393.8921221574565;5400.432954539717;5412.702301373462;5446.509814116748;5171.81898633546;5250.97374513125;5290.65610735301;5293.470652934676;5355.973220133875 09:45:07 INFO - PROCESS | 13450 | |1;ext.html;528.7726277700588;579.6637949989007;582.1616871704746;584.0888214385559;586.9002269614166;28035.859820700894;35184.64815351849;35422.82288588554;35507.112322191955;35570.99999999997;39019.21961560767;39820;39829.20341593166;39881.40177897334;39939.60060399395;8479.533625650587;8677.609507572175;8680.913190868105;8687.218150366465;8687.869681954775;8467.66129354825;8650.524221167832;8659.393842431033;8666.436681615707;8834.602442890053;8767.736967890973;8837.116288371144;8865.202131808135;8886.111388861094;8897.822043559125;8778.824423511525;8853.291736661116;8856.424332418372;8864.42381245217;8873.157050080232;8617.052124266325;8749.7812554686;8753.299736021103;8759.2992560595;8763.167499087576;38540.80729596362;38709;38841.80579097115;38900.61099388998;38924;3059.9235019124476;3605.264862871337;4003.4395184674167;4039.5354534228645;4160.521540022906;31333.216669583217;31456.842715786504;31938.20154496133;32016.839915800272;32035;3686.870959516431;3806.7715937043868;3926.607339266079;3941.5664276929515;3963.8810835674976;258323;259758;262757;263177;264522;60323.69838150781;61343;61463.6926815372;61669;61672;66666.33333666698;66692.666536667;66758.33241667619;67223.66388168027;67439;14346.067505612102;14484.85515144856;14485.203313817841;14586.41654333836;14598.708025839423;10755;10857.565697372016;10865.348079115278;10871.29336593119;10880.075193608474;19581.216751330074;20802.791972080387;20966.58066838655;20977.58044839125;21022.78977210208;6697.296783837724;8417.537035463109;8574.485530868043;8658.350623703247;8723.432976856611;910.3627460777482;1025.9281850270559;1035.596117514155;1086.7283179205199;1125.5216532973454;31387.215319616735;34466.310673786385;34626.30747385089;34958.47562286568;34995.82502087524;981.1464026297025;988.1501908358806;994.0357852882837;1042.4475028235047;1097.9780404391868;15445.84554154444;15537.689246215012;15549.766753498707;15569.484849393775;15772.68454630901;379181;384840;391999;651053;661306;52437.73781131146;52725.209121863205;53140;53172.20241696377;53281;1255.3723138430785;1271.841019872516;1281.814136950137;1301.9349032548523;1304.0806231606693;29705.365542851272;31377.8431107843;31469.527957080205;31774.682253177172;31939.840300798347;44763.55236447594;45149.77425112853;45314;45318;45335.54664453313;259701;282341;282828;283229;283549;29689.406211875208;29871.402571948875;29872.402551949275;30183.69816301809;30267.394652106395;38208.23583528258;39645.207095857346;40157;42457.36313955231;43508;35353.646463535035;35426.29147417089;35668.28663426665;36077.81961090178;36412.4538131923;36858;37180.44229336508;37279.81360093182;39765.80117099396;40776.796116020414;36612.45081323729;36684.44973325349;36709;37057.444138338484;37080;30503.847480762455;30511.7795288186;32816;32913.34173316568;32981.340373192885;25724.742752572234;25726.485470290863;25827.354316142246;26194;26358.20925372242 09:45:07 INFO - PROCESS | 13450 | |2;jquery.html;362.71345636946813;366.68648305698616;369.20436459429936;369.7374863846669;371.2963933346307;13810.309484525784;14736.926315368408;17105.657886842273;17390.21744021519;18150.818491815062;16777.91611041943;16974.32102715893;17155.31378744852;17159.656806863888;17368.305267789307;1451.3251338127768;1453.607525967988;1487.1077353587868;5471.562275017999;5648.774049038034;4030.2745505808944;5520.834374968757;5880.647161170344;6159.722812473449;6162.1681073055015;5948;6140.201773769404;6216.129741836146;6232.345603711613;6267.686615669221;6012.6392416455155;6024.518038556905;6037.245344331958;6067.423594758491;6069.150318955328;5079.187330027215;5307.628466007381;5308.734563271821;5308.92036619451;5309.469053094698;12151.513939442411;13712.862871371259;19391.4182574523;19906;19907.203711851507;1903.4670292318174;2002.4293076473282;2400.939976500584;2486.117428312959;2800.1459554835765;9377.671781487616;9531.332806703533;9790.657326993522;10863.239573229877;13246.933765331209;1844.8524118070657;1884.3593178319438;1888.9055547222583;1890.432870138953;1922.1158267197106;56888.715556422365;58525.70737146329;61235.69382153105;62086;63397.36602633961;10069.848952265722;10096.14182794456;10140.49297535135;10178.338408003456;10276.280660353854;13166.407511661999;13584.93207533956;13603.591892243248;13609.795853062213;13615.659608509668;7152.642367881585;7361.8159546011775;7365.7790266292095;7379.298966598165;7424.183339832614;7084.256153103953;7098.893516597255;7124.358807707331;7161.104861892263;7162;4100.507939047334;4380.277254253013;4457.888552786207;4467.977660111744;4579.885502862455;1794.9371771988178;1842.6130512592238;1847.251862995462;1854.147092337513;1868.3091801919286;887.600579739107;934.3739694404765;967;1012.3875055591409;1093.6117678224275;12870.67823304425;15238.771418428732;15775.946821305432;15997.600059998593;16908.746368804477;830.2647466794429;923.8198551282435;933.9719808405758;950.6767698982379;1003.5283416794096;9274.95362523183;9457.621695132255;9547.188488978376;9677.516124193762;9722.611095556098;352662;353819;356731.5431879615;377833;410137;71554;72257;72703.2729672707;72985.6350718243;75277;1126.1328776841785;1127.4588197665003;1131.4116659337262;1154.284343706907;1160.3733983648904;15656.92171539135;15721.764173537635;15742.449014284903;15751.527454176394;16005.199740013186;33640.66359336375;33672.3265534683;33962.66037339595;34766.65233347634;35486.645133548336;44414.555854441045;44829;44846.3273050911;44917.550824492646;49237;6763.222229443677;7707.614619269127;7815.14033456308;7876.56678882667;7888.881666775118;10336.483175841027;11568.24806387582;11891.405429728306;12106.273623582612;12259.816102758288;9686.564104615169;9909.55407006672;9925.17682528108;10198.541065651914;10251.794964100825;10366.948165259126;10372.792544149226;10532.736681583021;10624.893751062391;10685.305455145392;9769.16962058233;10059.446730429603;10126.949365253127;10328.173746100445;10346.793064138525;7745;7766.844663106819;7800.765977020698;7877.7636670899965;7885.053793544811;8446.197611226924;10359.32664376813;10490.947545262225;10709.357438553712;10765.515551800032 09:45:07 INFO - PROCESS | 13450 | |3;mootools.html;1292.5476083370816;1477.8226612806463;1500.077452366794;1702.6850032743944;1848.5933094719167;7377.188509263977;7873.488223265484;8022.277994980451;8027.799305017377;8035.437519373653;7590.316871481566;7769.417293702981;7788.688452461909;7794.649240784164;7806.531608103518;1898.392514395394;1934.1586409911663;2209.574824238365;2220.7224096987875;2233.698450709158;2274;2282.6347784354507;2283.954320913581;2284.1776960294283;2284.8629082255034;2177.3359125466727;2250.6173950428383;2268.0134141648437;2268.8184945204343;2272.329662749493;2091.592139532799;2151.3653472225733;2162.6755986602134;2184.213683074092;2190.266260802633;2204.437868343562;2231.8214542836695;2242.5627002734473;2249.8312626553075;2252.1779550464125;8192.795180120485;8294.958525207396;8302.211289927447;8314.459560128573;8315.168483151698;4653.627709783209;4760.190767569521;4785.019071090418;4813.109574728652;4816.397950256218;2836.1349788314556;2957.423302456022;2977.5384815353436;3014.351914338428;3023.9546406803697;944.1691311645708;950.144869617343;968.91279784819;992.4343124419084;1018.872640919885;11311.886881131166;11419.600313989054;11439.256448330832;11500.194986350958;11541.826872596834;4003.559608443069;4035.112275299488;4158.688098392633;4159.313713237282;4166.8749937501925;8994.550272486349;9063.728088157366;9192.81614367709;9193.850768653918;9214.078592140731;4689.835855745033;4734.502877197913;4760.428748550127;4764.047190561832;4765.189917713997;4390.846320378771;4401.207782599163;4402.449693788277;4403.053343531156;4406.581374769392;3266.6896644818703;3379.121428428626;3427.537282466835;3501.492283618861;3501.824908754552;1021.97445063874;1034.255336157965;1036.1296510930704;1069.994650026745;1072.5816931396762;1302.1275745250516;1321.6497628128554;1337.1041402260314;1347.818044563991;1356.071091302461;7566.772996810105;7594.658240379196;7605.923940760522;7611.923880761232;7659.502132361378;1085.3704851186294;1099.4502748625687;1102.311055590256;1113.1762495753246;1138.3966497756203;5996.16053752475;6198.380161983856;6206;6207.6585787782105;6223.190985171898;9858.359206651545;10315.84526232107;10321.896781032243;10336.948315258525;10339.534720937576;10022.398656080659;10248.743781405525;10250.179985601135;10262.486875656188;10306.948465257627;7345.926540734631;7480.9625951870985;7521.285477879593;7522.811929701801;7532.510386824729;7685.581664926101;7739.110002349802;7777.650005749641;7828.960855195687;7850.921490785019;9009.684661036832;9138.817223655356;9258.814823703622;9333;9345.205657518914;9427.764305892408;9490.383125096847;9581.904180958101;9588.616455341707;9719.805603888024;6857.622830744357;6963.8607227854145;6965.47758918073;6966.338197871194;6975.128108986377;6972.860542789014;7474.476786625101;7774.572398518136;7782.610869456391;7807.141214466517;7181.569105853457;7334.559926404433;7358.411327093927;7363.631818408951;7496.58768767723;7269.164046134762;7286.453515986216;7300.123985121607;7398.815029624302;7425.368843648351;7129.857402851811;7148.28517148281;7155.105611798525;7184.748533801292;7313.597752123685;6830.419414349836;6906.240313565403;6928.722851086101;6939.826504337432;6942.583444993316;6961;6993.510454268152;7018.543794653331;7042.859142817218;7047.15434147885 09:45:07 INFO - PROCESS | 13450 | |4;prototype.html;332.18283023761546;338.7781003442745;341.44685609312916;346.99826500867493;351.1081852095677;5814.156947242653;5858.648481091132;5916.4970977466855;5923.259592550931;5953.672548009858;5828.038373668351;5835.737391817368;5838.065909454488;5840.328362238344;5850.6782126983;4506.143832671798;4581.5647513486165;4582.9541704583025;4585.610223131038;4587.632989360844;4552.704074235181;4580.97709511452;4584.885377865547;4591.79336929839;4592.954070459303;4536.841210557631;4538.251188553884;4545.318202269653;4549.522300158485;4550.385697930787;4293.828246870122;4383.167198232358;4443.4445694288215;4537.795799189044;4538.546145385451;3996.0609256824623;4011.2579172853116;4026.879193624167;4030.4558884550797;4033.072393349517;5582.827606202703;5585.357683866367;5598.300212473441;5601.29983752031;5617.185508101344;4959.132151873444;5056.74716264189;5140.254663073871;5234.607404444644;5235.188545775411;6109.786157484511;6120.663363515005;6124.1732366130445;6139.416755408229;6141.324454310023;4405.140997505488;4406.823727050914;4439.067795762894;4440.644748420119;4451.287793952984;6342.270638876542;6427.485801135898;6494.025896115573;6508.121403610499;6508.772192973271;4545.4545454545005;4553.681242313006;4554.294084416921;4556.179887620194;4560.68075234737;4612.123696497655;4616.95383046172;4618.237990731492;4618.422697162855;4619.076184763061;5260.395054568774;5264.789408423697;5265.526102650703;5266.262723218752;5268.947310526845;6055.909161362583;6226.25284965807;6227.657478838707;6234.220722409699;6248.968920128128;1617.4581515192308;1645.843644853737;1647.2998975435391;1647.637519745678;1650.7853978982655;1102.862142232221;1104.5636973395465;1124.3029321820525;1124.8931351521592;1143.816989281711;5991.910121348184;5997.400259973968;5999.4900433463645;6000.759969601254;6004.3395226525045;6451.032345148265;6453.032045193258;6461.0631458438265;6463.741450342028;6465.030245463124;5960.0761881908375;5989.730462129215;5993.970030149909;5994.07091900756;6003.3996600339615;3392.6437724039115;3512.9824350878084;3516.1385460562324;3516.82415879205;3521.4893840393;6786.049953006583;6800.31996800316;6808.659567021629;6812.693428795617;6813.3527314905;6323.241211054611;6526.477881769447;6644.568103073285;6659.134312539339;6660;6761.256261811295;6781.898271525833;6787.5588086774205;6792.558483698544;6805.727770889208;6506.154199953976;6509.283978762238;6510.44661203803;6513.641749703812;6516.1980348450625;6307;6402.647854368054;6407.679616019087;6411.198600174978;6424.807255782334;6778.525503214728;6780.762673306411;6788.389044985975;6792.286809884891;6797.490188236001;4449.421575195204;4475.641948644035;4478.977605111953;4482.215612267905;4485.48416932044;6380.266269379081;6502.772402965874;6506.349365063646;6510.967445162744;6513.609183449008;6288.056791481132;6292.779752708633;6339.302676705466;6349.206349206349;6355.968220158869;6269.404406581368;6314.589551679126;6315.936840631535;6319.083732858801;6343.5876668016435;6074.088886667036;6220.440160385587;6226.470749986121;6231.594946328474;6238.095476156022;6367.777127800505;6374.490040796818;6380.7447702091395;6385.96807015962;6386.776462823779;6219.378062193925;6221.564490485623;6222.191115155001;6225.906611400923;6231.813045608639 09:45:07 INFO - PROCESS | 13450 | |5;yui.html;782.0447293857277;806.7216810200482;810.5744484145823;814.0963530481168;817.7046502594542;13368.933155334222;13482.595522134327;13523.729525409486;13568.118072325293;13599.45602175913;12955.611331660042;13100.672483187902;13123.475060997549;13141.408636611352;13237.80143297849;659.1661548141604;670.1422179610107;792.3700657976893;800.9959950200241;801.6873419366452;803.1526739290047;822.8601137806587;823.5717426937989;823.6540652925786;824.5464994253167;848.9490630562156;859.7549698335976;861.4960248254779;862.2455351567379;862.6894318045498;686.8145600687786;833.5248908122372;843.9872153415895;850.6087199888059;852.6418904060309;630.7477009196313;631.7157279224367;632.5635311634957;633.3128555517269;634.7714822663837;13220.471181152743;13303.334833258396;13308.134971226838;13313.86686133136;13336.599902002858;10838.132949364031;11126.554937802479;11200.383978881158;11512.481938312796;11810.52757889692;10257.897421025844;10258.17934565233;10405.16758659313;10510.10664093553;10969.23215374924;3573.3210689968823;3642.7814331140216;3662.7436079474446;3669.743117981742;3676.8529258829612;46303.30545041793;46447.303290450334;46472.3029154563;46712.53287467116;46874.76562617165;9257.629694812267;9532.142107210384;9578.13796758295;9635.470049147365;9656.27577931658;18582.628347432976;18614.06929653512;18632.72050919237;18660.440186794418;18662;7462.552246865097;7609.809754756176;7618.733344333033;7705.113911900091;7740.690372385154;4261.31818908973;4280.122574872144;4285.935710964338;4312.719673221293;4438.955610443919;3000.3849210911712;3027.909162725122;3032.651245106841;3042.0265515035417;3043.04144194578;548.9835304940858;554.3680204566797;559.8992181407385;563.9689817060101;569.3253494608902;636.4876274598993;645.5932762359777;650.6096342194645;672.6434989455596;677.1129819935801;7855.685772569148;7856.292933636;7950.1254861965135;7982.361411087215;8131.471454355448;475.1660835234211;528.6088294661922;561.9409961953936;632.4497687012237;635.841039740065;3643.872464463731;3920.941185882214;4051.8784436466954;4249.277622804069;4252.702310838212;49740.502594974314;50778.49221507811;50876.49123508792;50998.49001510011;51100.48899511032;45151.322730159074;45230;45389.54610453919;47104;47420.76289618599;42668.78665606652;43280;43387.78306108512;43553.78223108864;44585.55414445879;8364.958175209085;8443.577821109044;8514.914850851412;8626.260305919172;8635;32355.838220808746;32421.675783241866;32468.83765581157;32629;33426.164345890575;40320.798396007835;41308.58691413047;41610.79194604129;41646.79176604097;41912.3713144297;9208.447493150432;9388.624455021723;9401.482918439551;9526.666566670134;9961.800763984824;10842.457877105955;11064.170187235828;11305.039071678999;11321.320720756781;11517.481713322753;10265.897341026493;10375.325603835727;10409.063184313449;10684.145268378355;10715.981506934899;10275.280730348804;10446.322916302606;10485.790284194121;10768.246222764332;10839.458027098772;6806.897896531655;10554.611771759646;10581.15350771921;10757.515911784145;10844.566217351217;8699.91300086991;8880.911190888008;8957.731268061969;9049.638014479347;9086.500242486727;9093.818123637622;9145.222656074307;9261.16649501548;9409.388389754644;9589.808203836024 09:45:07 INFO - PROCESS | 13450 | __end_tp_report 09:45:07 INFO - PROCESS | 13450 | __start_cc_report 09:45:07 INFO - PROCESS | 13450 | _x_x_mozilla_cycle_collect,890 09:45:07 INFO - PROCESS | 13450 | __end_cc_report 09:45:07 INFO - PROCESS | 13450 | __startTimestamp1455126307417__endTimestamp 09:45:07 INFO - PROCESS | 13450 | 09:45:07 INFO - PROCESS | 13450 | ------- Summary: start ------- 09:45:07 INFO - PROCESS | 13450 | Number of tests: 6 09:45:07 INFO - PROCESS | 13450 | 09:45:07 INFO - PROCESS | 13450 | [#0] dojo.html Cycles:165 Average:5082.63 Median:5290.66 stddev:538.39 (10.2%) stddev-sans-first:518.13 09:45:07 INFO - PROCESS | 13450 | Values: 3144.7 3175.2 3213.4 3213.5 3252.1 4846.5 5055.9 5067.6 5114.2 5165.2 4994.5 5044.7 5046.3 5061.9 5073.9 4546.8 4651.5 4721.4 4751.5 4836.3 4594.3 4654.7 4745.6 4753.4 4813.9 4618.7 4646.3 4647.2 4673.0 4702.7 4634.3 4647.4 4670.2 4690.8 4737.0 4587.5 4641.2 4649.5 4652.6 4665.2 4795.1 4807.9 4818.0 4821.0 4988.6 5404.2 5408.5 5410.9 5411.5 5438.3 5410.6 5418.4 5418.7 5427.1 5427.7 5127.3 5128.2 5130.8 5201.6 5204.6 5624.4 5636.2 5650.1 5721.3 5721.7 5390.5 5393.0 5422.6 5433.5 5434.8 5376.6 5469.1 5483.4 5513.5 5554.3 5456.3 5513.2 5515.1 5555.9 5566.3 5507.5 5534.5 5537.5 5537.9 5538.8 4179.5 4313.9 4317.6 4326.1 4364.5 3824.9 3841.6 3860.5 3866.0 3882.3 4989.3 5003.1 5008.0 5032.2 5052.5 5287.1 5310.6 5357.5 5358.0 5399.9 5086.8 5099.6 5104.0 5140.6 5179.9 4591.7 4610.7 4616.9 4639.9 4679.2 5554.1 5573.6 5622.1 5624.9 5633.9 5526.9 5530.5 5556.2 5562.2 5603.2 5605.3 5605.4 5605.4 5611.0 5612.4 5363.9 5373.6 5401.9 5446.3 5475.2 5497.5 5505.9 5506.8 5508.1 5509.4 5321.8 5339.1 5368.1 5369.3 5417.9 5189.0 5260.9 5349.6 5350.4 5423.0 5253.4 5268.1 5293.1 5297.9 5300.8 5386.1 5393.9 5400.4 5412.7 5446.5 5171.8 5251.0 5290.7 5293.5 5356.0 09:45:07 INFO - PROCESS | 13450 | 09:45:07 INFO - PROCESS | 13450 | [#1] ext.html Cycles:180 Average:50954.57 Median:37230.13 stddev:98062.53 (263.4%) stddev-sans-first:98264.53 09:45:07 INFO - PROCESS | 13450 | Values: 528.8 579.7 582.2 584.1 586.9 28035.9 35184.6 35422.8 35507.1 35571.0 39019.2 39820.0 39829.2 39881.4 39939.6 8479.5 8677.6 8680.9 8687.2 8687.9 8467.7 8650.5 8659.4 8666.4 8834.6 8767.7 8837.1 8865.2 8886.1 8897.8 8778.8 8853.3 8856.4 8864.4 8873.2 8617.1 8749.8 8753.3 8759.3 8763.2 38540.8 38709.0 38841.8 38900.6 38924.0 3059.9 3605.3 4003.4 4039.5 4160.5 31333.2 31456.8 31938.2 32016.8 32035.0 3686.9 3806.8 3926.6 3941.6 3963.9 258323.0 259758.0 262757.0 263177.0 264522.0 60323.7 61343.0 61463.7 61669.0 61672.0 66666.3 66692.7 66758.3 67223.7 67439.0 14346.1 14484.9 14485.2 14586.4 14598.7 10755.0 10857.6 10865.3 10871.3 10880.1 19581.2 20802.8 20966.6 20977.6 21022.8 6697.3 8417.5 8574.5 8658.4 8723.4 910.4 1025.9 1035.6 1086.7 1125.5 31387.2 34466.3 34626.3 34958.5 34995.8 981.1 988.2 994.0 1042.4 1098.0 15445.8 15537.7 15549.8 15569.5 15772.7 379181.0 384840.0 391999.0 651053.0 661306.0 52437.7 52725.2 53140.0 53172.2 53281.0 1255.4 1271.8 1281.8 1301.9 1304.1 29705.4 31377.8 31469.5 31774.7 31939.8 44763.6 45149.8 45314.0 45318.0 45335.5 259701.0 282341.0 282828.0 283229.0 283549.0 29689.4 29871.4 29872.4 30183.7 30267.4 38208.2 39645.2 40157.0 42457.4 43508.0 35353.6 35426.3 35668.3 36077.8 36412.5 36858.0 37180.4 37279.8 39765.8 40776.8 36612.5 36684.4 36709.0 37057.4 37080.0 30503.8 30511.8 32816.0 32913.3 32981.3 25724.7 25726.5 25827.4 26194.0 26358.2 09:45:07 INFO - PROCESS | 13450 | 09:45:07 INFO - PROCESS | 13450 | [#2] jquery.html Cycles:180 Average:23086.19 Median:178547.13 stddev:61045.59 (34.2%) stddev-sans-first:61193.00 09:45:07 INFO - PROCESS | 13450 | Values: 362.7 366.7 369.2 369.7 371.3 13810.3 14736.9 17105.7 17390.2 18150.8 16777.9 16974.3 17155.3 17159.7 17368.3 1451.3 1453.6 1487.1 5471.6 5648.8 4030.3 5520.8 5880.6 6159.7 6162.2 5948.0 6140.2 6216.1 6232.3 6267.7 6012.6 6024.5 6037.2 6067.4 6069.2 5079.2 5307.6 5308.7 5308.9 5309.5 12151.5 13712.9 19391.4 19906.0 19907.2 1903.5 2002.4 2400.9 2486.1 2800.1 9377.7 9531.3 9790.7 10863.2 13246.9 1844.9 1884.4 1888.9 1890.4 1922.1 56888.7 58525.7 61235.7 62086.0 63397.4 10069.8 10096.1 10140.5 10178.3 10276.3 13166.4 13584.9 13603.6 13609.8 13615.7 7152.6 7361.8 7365.8 7379.3 7424.2 7084.3 7098.9 7124.4 7161.1 7162.0 4100.5 4380.3 4457.9 4468.0 4579.9 1794.9 1842.6 1847.3 1854.1 1868.3 887.6 934.4 967.0 1012.4 1093.6 12870.7 15238.8 15775.9 15997.6 16908.7 830.3 923.8 934.0 950.7 1003.5 9275.0 9457.6 9547.2 9677.5 9722.6 352662.0 353819.0 356731.5 377833.0 410137.0 71554.0 72257.0 72703.3 72985.6 75277.0 1126.1 1127.5 1131.4 1154.3 1160.4 15656.9 15721.8 15742.4 15751.5 16005.2 33640.7 33672.3 33962.7 34766.7 35486.6 44414.6 44829.0 44846.3 44917.6 49237.0 6763.2 7707.6 7815.1 7876.6 7888.9 10336.5 11568.2 11891.4 12106.3 12259.8 9686.6 9909.6 9925.2 10198.5 10251.8 10366.9 10372.8 10532.7 10624.9 10685.3 9769.2 10059.4 10126.9 10328.2 10346.8 7745.0 7766.8 7800.8 7877.8 7885.1 8446.2 10359.3 10490.9 10709.4 10765.5 09:45:07 INFO - PROCESS | 13450 | 09:45:07 INFO - PROCESS | 13450 | [#3] mootools.html Cycles:180 Average:5679.90 Median:6097.27 stddev:3069.08 (50.3%) stddev-sans-first:3059.97 09:45:07 INFO - PROCESS | 13450 | Values: 1292.5 1477.8 1500.1 1702.7 1848.6 7377.2 7873.5 8022.3 8027.8 8035.4 7590.3 7769.4 7788.7 7794.6 7806.5 1898.4 1934.2 2209.6 2220.7 2233.7 2274.0 2282.6 2284.0 2284.2 2284.9 2177.3 2250.6 2268.0 2268.8 2272.3 2091.6 2151.4 2162.7 2184.2 2190.3 2204.4 2231.8 2242.6 2249.8 2252.2 8192.8 8295.0 8302.2 8314.5 8315.2 4653.6 4760.2 4785.0 4813.1 4816.4 2836.1 2957.4 2977.5 3014.4 3024.0 944.2 950.1 968.9 992.4 1018.9 11311.9 11419.6 11439.3 11500.2 11541.8 4003.6 4035.1 4158.7 4159.3 4166.9 8994.6 9063.7 9192.8 9193.9 9214.1 4689.8 4734.5 4760.4 4764.0 4765.2 4390.8 4401.2 4402.4 4403.1 4406.6 3266.7 3379.1 3427.5 3501.5 3501.8 1022.0 1034.3 1036.1 1070.0 1072.6 1302.1 1321.6 1337.1 1347.8 1356.1 7566.8 7594.7 7605.9 7611.9 7659.5 1085.4 1099.5 1102.3 1113.2 1138.4 5996.2 6198.4 6206.0 6207.7 6223.2 9858.4 10315.8 10321.9 10336.9 10339.5 10022.4 10248.7 10250.2 10262.5 10306.9 7345.9 7481.0 7521.3 7522.8 7532.5 7685.6 7739.1 7777.7 7829.0 7850.9 9009.7 9138.8 9258.8 9333.0 9345.2 9427.8 9490.4 9581.9 9588.6 9719.8 6857.6 6963.9 6965.5 6966.3 6975.1 6972.9 7474.5 7774.6 7782.6 7807.1 7181.6 7334.6 7358.4 7363.6 7496.6 7269.2 7286.5 7300.1 7398.8 7425.4 7129.9 7148.3 7155.1 7184.7 7313.6 6830.4 6906.2 6928.7 6939.8 6942.6 6961.0 6993.5 7018.5 7042.9 7047.2 09:45:07 INFO - PROCESS | 13450 | 09:45:07 INFO - PROCESS | 13450 | [#4] prototype.html Cycles:180 Average:5264.81 Median:5974.90 stddev:1570.68 (26.3%) stddev-sans-first:1530.83 09:45:07 INFO - PROCESS | 13450 | Values: 332.2 338.8 341.4 347.0 351.1 5814.2 5858.6 5916.5 5923.3 5953.7 5828.0 5835.7 5838.1 5840.3 5850.7 4506.1 4581.6 4583.0 4585.6 4587.6 4552.7 4581.0 4584.9 4591.8 4593.0 4536.8 4538.3 4545.3 4549.5 4550.4 4293.8 4383.2 4443.4 4537.8 4538.5 3996.1 4011.3 4026.9 4030.5 4033.1 5582.8 5585.4 5598.3 5601.3 5617.2 4959.1 5056.7 5140.3 5234.6 5235.2 6109.8 6120.7 6124.2 6139.4 6141.3 4405.1 4406.8 4439.1 4440.6 4451.3 6342.3 6427.5 6494.0 6508.1 6508.8 4545.5 4553.7 4554.3 4556.2 4560.7 4612.1 4617.0 4618.2 4618.4 4619.1 5260.4 5264.8 5265.5 5266.3 5268.9 6055.9 6226.3 6227.7 6234.2 6249.0 1617.5 1645.8 1647.3 1647.6 1650.8 1102.9 1104.6 1124.3 1124.9 1143.8 5991.9 5997.4 5999.5 6000.8 6004.3 6451.0 6453.0 6461.1 6463.7 6465.0 5960.1 5989.7 5994.0 5994.1 6003.4 3392.6 3513.0 3516.1 3516.8 3521.5 6786.0 6800.3 6808.7 6812.7 6813.4 6323.2 6526.5 6644.6 6659.1 6660.0 6761.3 6781.9 6787.6 6792.6 6805.7 6506.2 6509.3 6510.4 6513.6 6516.2 6307.0 6402.6 6407.7 6411.2 6424.8 6778.5 6780.8 6788.4 6792.3 6797.5 4449.4 4475.6 4479.0 4482.2 4485.5 6380.3 6502.8 6506.3 6511.0 6513.6 6288.1 6292.8 6339.3 6349.2 6356.0 6269.4 6314.6 6315.9 6319.1 6343.6 6074.1 6220.4 6226.5 6231.6 6238.1 6367.8 6374.5 6380.7 6386.0 6386.8 6219.4 6221.6 6222.2 6225.9 6231.8 09:45:07 INFO - PROCESS | 13450 | 09:45:07 INFO - PROCESS | 13450 | [#5] yui.html Cycles:180 Average:12949.12 Median:46793.65 stddev:14629.75 (31.3%) stddev-sans-first:14642.26 09:45:07 INFO - PROCESS | 13450 | Values: 782.0 806.7 810.6 814.1 817.7 13368.9 13482.6 13523.7 13568.1 13599.5 12955.6 13100.7 13123.5 13141.4 13237.8 659.2 670.1 792.4 801.0 801.7 803.2 822.9 823.6 823.7 824.5 848.9 859.8 861.5 862.2 862.7 686.8 833.5 844.0 850.6 852.6 630.7 631.7 632.6 633.3 634.8 13220.5 13303.3 13308.1 13313.9 13336.6 10838.1 11126.6 11200.4 11512.5 11810.5 10257.9 10258.2 10405.2 10510.1 10969.2 3573.3 3642.8 3662.7 3669.7 3676.9 46303.3 46447.3 46472.3 46712.5 46874.8 9257.6 9532.1 9578.1 9635.5 9656.3 18582.6 18614.1 18632.7 18660.4 18662.0 7462.6 7609.8 7618.7 7705.1 7740.7 4261.3 4280.1 4285.9 4312.7 4439.0 3000.4 3027.9 3032.7 3042.0 3043.0 549.0 554.4 559.9 564.0 569.3 636.5 645.6 650.6 672.6 677.1 7855.7 7856.3 7950.1 7982.4 8131.5 475.2 528.6 561.9 632.4 635.8 3643.9 3920.9 4051.9 4249.3 4252.7 49740.5 50778.5 50876.5 50998.5 51100.5 45151.3 45230.0 45389.5 47104.0 47420.8 42668.8 43280.0 43387.8 43553.8 44585.6 8365.0 8443.6 8514.9 8626.3 8635.0 32355.8 32421.7 32468.8 32629.0 33426.2 40320.8 41308.6 41610.8 41646.8 41912.4 9208.4 9388.6 9401.5 9526.7 9961.8 10842.5 11064.2 11305.0 11321.3 11517.5 10265.9 10375.3 10409.1 10684.1 10716.0 10275.3 10446.3 10485.8 10768.2 10839.5 6806.9 10554.6 10581.2 10757.5 10844.6 8699.9 8880.9 8957.7 9049.6 9086.5 9093.8 9145.2 9261.2 9409.4 9589.8 09:45:07 INFO - PROCESS | 13450 | -------- Summary: end -------- 09:45:07 INFO - PROCESS | 13450 | 09:45:08 INFO - TEST-INFO | 13450: exit 0 09:45:08 INFO - TEST-OK | dromaeo_css | took 1112399ms 09:45:08 INFO - TEST-START | kraken 09:45:08 INFO - operating with platform_type : linux_ 09:45:08 INFO - Initialising browser for kraken test... 09:45:08 INFO - TEST-INFO | started process 13632 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYK3hCn/profile http://localhost:33604/getInfo.html) 09:45:12 INFO - PROCESS | 13632 | __metrics Screen width/height:1600/1200 09:45:12 INFO - PROCESS | 13632 | colorDepth:24 09:45:12 INFO - PROCESS | 13632 | Browser inner width/height: 1024/697 09:45:12 INFO - PROCESS | 13632 | __metrics 09:45:12 INFO - PROCESS | 13632 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:45:13 INFO - TEST-INFO | 13632: exit 0 09:45:13 INFO - Browser initialized. 09:45:13 INFO - Running cycle 1/1 for kraken test... 09:45:13 INFO - TEST-INFO | started process 13712 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYK3hCn/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:45:25 INFO - PROCESS | 13712 | RSS: Main: 152756224 09:45:25 INFO - PROCESS | 13712 | 09:45:27 INFO - PROCESS | 13712 | Cycle 1(1): loaded http://localhost:33604/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33604/tests/kraken/driver.html?testName=audio-beat-detection) 09:45:28 INFO - PROCESS | 13712 | RSS: Main: 192950272 09:45:28 INFO - PROCESS | 13712 | 09:45:30 INFO - PROCESS | 13712 | Cycle 1(1): loaded http://localhost:33604/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33604/tests/kraken/driver.html?testName=audio-dft) 09:45:31 INFO - PROCESS | 13712 | RSS: Main: 183939072 09:45:31 INFO - PROCESS | 13712 | 09:45:34 INFO - PROCESS | 13712 | Cycle 1(1): loaded http://localhost:33604/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33604/tests/kraken/driver.html?testName=audio-fft) 09:45:35 INFO - PROCESS | 13712 | RSS: Main: 168390656 09:45:35 INFO - PROCESS | 13712 | 09:45:37 INFO - PROCESS | 13712 | Cycle 1(1): loaded http://localhost:33604/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33604/tests/kraken/driver.html?testName=audio-oscillator) 09:45:37 INFO - PROCESS | 13712 | RSS: Main: 169824256 09:45:37 INFO - PROCESS | 13712 | 09:45:39 INFO - PROCESS | 13712 | Cycle 1(1): loaded http://localhost:33604/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33604/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:45:40 INFO - PROCESS | 13712 | RSS: Main: 171606016 09:45:40 INFO - PROCESS | 13712 | 09:45:43 INFO - PROCESS | 13712 | Cycle 1(1): loaded http://localhost:33604/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33604/tests/kraken/driver.html?testName=imaging-darkroom) 09:45:44 INFO - PROCESS | 13712 | RSS: Main: 170172416 09:45:44 INFO - PROCESS | 13712 | 09:45:47 INFO - PROCESS | 13712 | Cycle 1(1): loaded http://localhost:33604/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33604/tests/kraken/driver.html?testName=imaging-desaturate) 09:45:48 INFO - PROCESS | 13712 | RSS: Main: 171651072 09:45:48 INFO - PROCESS | 13712 | 09:45:50 INFO - PROCESS | 13712 | Cycle 1(1): loaded http://localhost:33604/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33604/tests/kraken/driver.html?testName=json-parse-financial) 09:45:51 INFO - PROCESS | 13712 | RSS: Main: 173416448 09:45:51 INFO - PROCESS | 13712 | 09:45:52 INFO - PROCESS | 13712 | Cycle 1(1): loaded http://localhost:33604/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33604/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:45:53 INFO - PROCESS | 13712 | RSS: Main: 183357440 09:45:53 INFO - PROCESS | 13712 | 09:45:55 INFO - PROCESS | 13712 | Cycle 1(1): loaded http://localhost:33604/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33604/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:45:55 INFO - PROCESS | 13712 | RSS: Main: 180269056 09:45:55 INFO - PROCESS | 13712 | 09:45:57 INFO - PROCESS | 13712 | Cycle 1(1): loaded http://localhost:33604/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33604/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:45:58 INFO - PROCESS | 13712 | RSS: Main: 190218240 09:45:58 INFO - PROCESS | 13712 | 09:46:01 INFO - PROCESS | 13712 | Cycle 1(1): loaded http://localhost:33604/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33604/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:46:01 INFO - PROCESS | 13712 | RSS: Main: 196964352 09:46:01 INFO - PROCESS | 13712 | 09:46:04 INFO - PROCESS | 13712 | Cycle 1(1): loaded http://localhost:33604/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33604/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:46:04 INFO - PROCESS | 13712 | RSS: Main: 195764224 09:46:04 INFO - PROCESS | 13712 | 09:46:06 INFO - PROCESS | 13712 | Cycle 1(1): loaded http://localhost:33604/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33604/tests/kraken/driver.html?testName=ai-astar) 09:46:06 INFO - PROCESS | 13712 | RSS: Main: 257404928 09:46:06 INFO - PROCESS | 13712 | 09:46:06 INFO - PROCESS | 13712 | __start_tp_report 09:46:06 INFO - PROCESS | 13712 | _x_x_mozilla_page_load 09:46:06 INFO - PROCESS | 13712 | _x_x_mozilla_page_load_details 09:46:06 INFO - PROCESS | 13712 | |i|pagename|runs| 09:46:06 INFO - PROCESS | 13712 | |0;ai-astar;109;110;106;110;111;112;101;112;110;111 09:46:06 INFO - PROCESS | 13712 | |1;audio-beat-detection;154;126;149;169;129;164;155;130;184;128 09:46:06 INFO - PROCESS | 13712 | |2;audio-dft;162;162;163;162;161;159;162;163;161;161 09:46:06 INFO - PROCESS | 13712 | |3;audio-fft;73;73;92;93;73;73;74;128;93;76 09:46:06 INFO - PROCESS | 13712 | |4;audio-oscillator;95;96;144;95;96;95;140;95;96;139 09:46:06 INFO - PROCESS | 13712 | |5;imaging-gaussian-blur;119;115;114;115;115;114;114;115;115;115 09:46:06 INFO - PROCESS | 13712 | |6;imaging-darkroom;145;145;145;145;145;146;146;146;146;145 09:46:06 INFO - PROCESS | 13712 | |7;imaging-desaturate;96;96;96;96;96;96;96;96;95;96 09:46:06 INFO - PROCESS | 13712 | |8;json-parse-financial;54;55;57;53;54;54;57;62;52;54 09:46:06 INFO - PROCESS | 13712 | |9;json-stringify-tinderbox;67;67;68;67;68;67;68;67;67;68 09:46:06 INFO - PROCESS | 13712 | |10;stanford-crypto-aes;84;85;85;85;86;86;92;86;87;86 09:46:06 INFO - PROCESS | 13712 | |11;stanford-crypto-ccm;119;117;115;127;113;129;132;126;118;128 09:46:06 INFO - PROCESS | 13712 | |12;stanford-crypto-pbkdf2;152;153;145;151;150;141;150;148;147;154 09:46:06 INFO - PROCESS | 13712 | |13;stanford-crypto-sha256-iterative;69;71;70;69;68;67;68;70;68;67 09:46:06 INFO - PROCESS | 13712 | __end_tp_report 09:46:06 INFO - PROCESS | 13712 | __start_cc_report 09:46:06 INFO - PROCESS | 13712 | _x_x_mozilla_cycle_collect,990 09:46:06 INFO - PROCESS | 13712 | __end_cc_report 09:46:06 INFO - PROCESS | 13712 | __startTimestamp1455126366788__endTimestamp 09:46:06 INFO - PROCESS | 13712 | 09:46:06 INFO - PROCESS | 13712 | ------- Summary: start ------- 09:46:06 INFO - PROCESS | 13712 | Number of tests: 14 09:46:06 INFO - PROCESS | 13712 | 09:46:06 INFO - PROCESS | 13712 | [#0] ai-astar Cycles:10 Average:109.20 Median:110.50 stddev:3.36 (3.0%) stddev-sans-first:3.56 09:46:06 INFO - PROCESS | 13712 | Values: 109.0 110.0 106.0 110.0 111.0 112.0 101.0 112.0 110.0 111.0 09:46:06 INFO - PROCESS | 13712 | 09:46:06 INFO - PROCESS | 13712 | [#1] audio-beat-detection Cycles:10 Average:148.80 Median:154.50 stddev:20.12 (13.0%) stddev-sans-first:21.25 09:46:06 INFO - PROCESS | 13712 | Values: 154.0 126.0 149.0 169.0 129.0 164.0 155.0 130.0 184.0 128.0 09:46:06 INFO - PROCESS | 13712 | 09:46:06 INFO - PROCESS | 13712 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.17 (0.7%) stddev-sans-first:1.24 09:46:06 INFO - PROCESS | 13712 | Values: 162.0 162.0 163.0 162.0 161.0 159.0 162.0 163.0 161.0 161.0 09:46:06 INFO - PROCESS | 13712 | 09:46:06 INFO - PROCESS | 13712 | [#3] audio-fft Cycles:10 Average:84.80 Median:75.00 stddev:17.65 (23.5%) stddev-sans-first:18.20 09:46:06 INFO - PROCESS | 13712 | Values: 73.0 73.0 92.0 93.0 73.0 73.0 74.0 128.0 93.0 76.0 09:46:06 INFO - PROCESS | 13712 | 09:46:06 INFO - PROCESS | 13712 | [#4] audio-oscillator Cycles:10 Average:109.10 Median:95.00 stddev:22.05 (23.2%) stddev-sans-first:22.79 09:46:06 INFO - PROCESS | 13712 | Values: 95.0 96.0 144.0 95.0 96.0 95.0 140.0 95.0 96.0 139.0 09:46:06 INFO - PROCESS | 13712 | 09:46:06 INFO - PROCESS | 13712 | [#5] imaging-gaussian-blur Cycles:10 Average:115.10 Median:115.00 stddev:1.45 (1.3%) stddev-sans-first:0.50 09:46:06 INFO - PROCESS | 13712 | Values: 119.0 115.0 114.0 115.0 115.0 114.0 114.0 115.0 115.0 115.0 09:46:06 INFO - PROCESS | 13712 | 09:46:06 INFO - PROCESS | 13712 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 09:46:06 INFO - PROCESS | 13712 | Values: 145.0 145.0 145.0 145.0 145.0 146.0 146.0 146.0 146.0 145.0 09:46:06 INFO - PROCESS | 13712 | 09:46:06 INFO - PROCESS | 13712 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 09:46:06 INFO - PROCESS | 13712 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 09:46:06 INFO - PROCESS | 13712 | 09:46:06 INFO - PROCESS | 13712 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:54.50 stddev:2.86 (5.2%) stddev-sans-first:3.00 09:46:06 INFO - PROCESS | 13712 | Values: 54.0 55.0 57.0 53.0 54.0 54.0 57.0 62.0 52.0 54.0 09:46:06 INFO - PROCESS | 13712 | 09:46:06 INFO - PROCESS | 13712 | [#9] json-stringify-tinderbox Cycles:10 Average:67.40 Median:67.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 09:46:06 INFO - PROCESS | 13712 | Values: 67.0 67.0 68.0 67.0 68.0 67.0 68.0 67.0 67.0 68.0 09:46:06 INFO - PROCESS | 13712 | 09:46:06 INFO - PROCESS | 13712 | [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:86.00 stddev:2.20 (2.6%) stddev-sans-first:2.19 09:46:06 INFO - PROCESS | 13712 | Values: 84.0 85.0 85.0 85.0 86.0 86.0 92.0 86.0 87.0 86.0 09:46:06 INFO - PROCESS | 13712 | 09:46:06 INFO - PROCESS | 13712 | [#11] stanford-crypto-ccm Cycles:10 Average:122.40 Median:126.50 stddev:6.70 (5.3%) stddev-sans-first:7.00 09:46:06 INFO - PROCESS | 13712 | Values: 119.0 117.0 115.0 127.0 113.0 129.0 132.0 126.0 118.0 128.0 09:46:06 INFO - PROCESS | 13712 | 09:46:06 INFO - PROCESS | 13712 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.10 Median:150.50 stddev:3.96 (2.6%) stddev-sans-first:4.06 09:46:06 INFO - PROCESS | 13712 | Values: 152.0 153.0 145.0 151.0 150.0 141.0 150.0 148.0 147.0 154.0 09:46:06 INFO - PROCESS | 13712 | 09:46:06 INFO - PROCESS | 13712 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:1.34 (1.9%) stddev-sans-first:1.41 09:46:06 INFO - PROCESS | 13712 | Values: 69.0 71.0 70.0 69.0 68.0 67.0 68.0 70.0 68.0 67.0 09:46:06 INFO - PROCESS | 13712 | -------- Summary: end -------- 09:46:06 INFO - PROCESS | 13712 | 09:46:07 INFO - TEST-INFO | 13712: exit 0 09:46:07 INFO - TEST-OK | kraken | took 59553ms 09:46:07 INFO - SUITE-END | took 1171s 09:46:07 INFO - Completed test suite (00:19:32) 09:46:07 INFO - Working with test: dromaeo_css 09:46:07 INFO - Generating results file: dromaeo_css 09:46:07 INFO - Working with test: kraken 09:46:07 INFO - Generating results file: kraken 09:46:07 INFO - javascript benchmark 09:46:07 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:46:08 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 09:46:08 INFO - process_Request line: dromaeo_css 6844.53 graph.html#tests=[[72,1,35]] 09:46:08 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:46:08 INFO - process_Request line: kraken 1518.90 graph.html#tests=[[232,1,35]] 09:46:08 INFO - RETURN: dromaeo_css: 6844.53 09:46:08 INFO - RETURN: kraken: 1518.90 09:46:08 INFO - javascript benchmark 09:46:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3144.654088050314, 3175.1744546417926, 3213.3733921885228, 3213.453712868812, 3252.0894149638093, 4846.4911184325665, 5055.873603159927, 5067.6452648314635, 5114.232865070241, 5165.173572228439, 4994.525520075596, 5044.747762611873, 5046.268291097788, 5061.898762024757, 5073.873153171173, 4546.772661366935, 4651.511591282909, 4721.386219791422, 4751.453582837966, 4836.250381190904, 4594.264917613183, 4654.6974446661025, 4745.644076694244, 4753.3582966299455, 4813.927791083137, 4618.722876627413, 4646.279826626845, 4647.23320652092, 4672.9953060092075, 4702.670813043088, 4634.3048542718525, 4647.3958385410015, 4670.182718024366, 4690.812367505296, 4737.028909073631, 4587.541245875419, 4641.234196357597, 4649.488556258809, 4652.62778977681, 4665.206914824488, 4795.088933102699, 4807.855764327076, 4817.975910120427, 4821.0357928414105, 4988.55103040728, 5404.189371594253, 5408.4591540845995, 5410.91883621746, 5411.540019098381, 5438.293021907127, 5410.594205434569, 5418.431064738224, 5418.674879507203, 5427.050266203399, 5427.674339539641, 5127.282180494733, 5128.153854613947, 5130.820421285237, 5201.635885487979, 5204.609654275944, 5624.409437009137, 5636.154576813511, 5650.067738823048, 5721.313442386941, 5721.713914304268, 5390.54180394663, 5392.973035134799, 5422.6475279106735, 5433.510984011379, 5434.755436005389, 5376.569874410116, 5469.097598896137, 5483.424240454695, 5513.5037846594, 5554.277943867352, 5456.345238571397, 5513.2005859151, 5515.090010148361, 5555.861103472364, 5566.304211973504, 5507.504324610804, 5534.501894829405, 5537.501624853782, 5537.916931246034, 5538.75075621598, 4179.519355274182, 4313.935290970638, 4317.6114149726045, 4326.091520780608, 4364.519902810688, 3824.8852534424013, 3841.5582208045876, 3860.536735591747, 3866.0, 3882.3400021996326, 4989.276554899519, 5003.074431230234, 5007.974960125176, 5032.245163225545, 5052.520010598987, 5287.07476191665, 5310.575153987672, 5357.5446087082255, 5357.955198736287, 5399.947010332948, 5086.796528138907, 5099.643024988215, 5103.97448012765, 5140.56305214061, 5179.948200517946, 4591.655625828076, 4610.654200934943, 4616.907661846812, 4639.884002899887, 4679.22792739201, 5554.055810512223, 5573.637713548606, 5622.128570071563, 5624.915626265528, 5633.915491267634, 5526.861828454321, 5530.529904957963, 5556.194351819045, 5562.249096371938, 5603.159526071122, 5605.327360716577, 5605.355384130714, 5605.4114317997655, 5611.0, 5612.382637909745, 5363.946360536344, 5373.596980226577, 5401.864953376197, 5446.319210098738, 5475.233467314659, 5497.47773961473, 5505.889882202254, 5506.752196151103, 5508.14623733322, 5509.393966663583, 5321.840344789663, 5339.065663508793, 5368.114261146867, 5369.328833895763, 5417.945820541744, 5188.9740551297, 5260.86847828792, 5349.598780091431, 5350.384705758887, 5422.996745602076, 5253.448387919213, 5268.104422248303, 5293.100172970681, 5297.894042119213, 5300.761465734128, 5386.057439947915, 5393.8921221574565, 5400.432954539717, 5412.702301373462, 5446.509814116748, 5171.81898633546, 5250.97374513125, 5290.65610735301, 5293.470652934676, 5355.973220133875], "unit": "score", "name": "dojo.html", "value": 5050.105443427294}, {"lowerIsBetter": false, "replicates": [528.7726277700588, 579.6637949989007, 582.1616871704746, 584.0888214385559, 586.9002269614166, 28035.859820700894, 35184.64815351849, 35422.82288588554, 35507.112322191955, 35570.99999999997, 39019.21961560767, 39820.0, 39829.20341593166, 39881.40177897334, 39939.60060399395, 8479.533625650587, 8677.609507572175, 8680.913190868105, 8687.218150366465, 8687.869681954775, 8467.66129354825, 8650.524221167832, 8659.393842431033, 8666.436681615707, 8834.602442890053, 8767.736967890973, 8837.116288371144, 8865.202131808135, 8886.111388861094, 8897.822043559125, 8778.824423511525, 8853.291736661116, 8856.424332418372, 8864.42381245217, 8873.157050080232, 8617.052124266325, 8749.7812554686, 8753.299736021103, 8759.2992560595, 8763.167499087576, 38540.80729596362, 38709.0, 38841.80579097115, 38900.61099388998, 38924.0, 3059.9235019124476, 3605.264862871337, 4003.4395184674167, 4039.5354534228645, 4160.521540022906, 31333.216669583217, 31456.842715786504, 31938.20154496133, 32016.839915800272, 32035.0, 3686.870959516431, 3806.7715937043868, 3926.607339266079, 3941.5664276929515, 3963.8810835674976, 258323.0, 259758.0, 262757.0, 263177.0, 264522.0, 60323.69838150781, 61343.0, 61463.6926815372, 61669.0, 61672.0, 66666.33333666698, 66692.666536667, 66758.33241667619, 67223.66388168027, 67439.0, 14346.067505612102, 14484.85515144856, 14485.203313817841, 14586.41654333836, 14598.708025839423, 10755.0, 10857.565697372016, 10865.348079115278, 10871.29336593119, 10880.075193608474, 19581.216751330074, 20802.791972080387, 20966.58066838655, 20977.58044839125, 21022.78977210208, 6697.296783837724, 8417.537035463109, 8574.485530868043, 8658.350623703247, 8723.432976856611, 910.3627460777482, 1025.9281850270559, 1035.596117514155, 1086.7283179205199, 1125.5216532973454, 31387.215319616735, 34466.310673786385, 34626.30747385089, 34958.47562286568, 34995.82502087524, 981.1464026297025, 988.1501908358806, 994.0357852882837, 1042.4475028235047, 1097.9780404391868, 15445.84554154444, 15537.689246215012, 15549.766753498707, 15569.484849393775, 15772.68454630901, 379181.0, 384840.0, 391999.0, 651053.0, 661306.0, 52437.73781131146, 52725.209121863205, 53140.0, 53172.20241696377, 53281.0, 1255.3723138430785, 1271.841019872516, 1281.814136950137, 1301.9349032548523, 1304.0806231606693, 29705.365542851272, 31377.8431107843, 31469.527957080205, 31774.682253177172, 31939.840300798347, 44763.55236447594, 45149.77425112853, 45314.0, 45318.0, 45335.54664453313, 259701.0, 282341.0, 282828.0, 283229.0, 283549.0, 29689.406211875208, 29871.402571948875, 29872.402551949275, 30183.69816301809, 30267.394652106395, 38208.23583528258, 39645.207095857346, 40157.0, 42457.36313955231, 43508.0, 35353.646463535035, 35426.29147417089, 35668.28663426665, 36077.81961090178, 36412.4538131923, 36858.0, 37180.44229336508, 37279.81360093182, 39765.80117099396, 40776.796116020414, 36612.45081323729, 36684.44973325349, 36709.0, 37057.444138338484, 37080.0, 30503.847480762455, 30511.7795288186, 32816.0, 32913.34173316568, 32981.340373192885, 25724.742752572234, 25726.485470290863, 25827.354316142246, 26194.0, 26358.20925372242], "unit": "score", "name": "ext.html", "value": 18823.72064598788}, {"lowerIsBetter": false, "replicates": [362.71345636946813, 366.68648305698616, 369.20436459429936, 369.7374863846669, 371.2963933346307, 13810.309484525784, 14736.926315368408, 17105.657886842273, 17390.21744021519, 18150.818491815062, 16777.91611041943, 16974.32102715893, 17155.31378744852, 17159.656806863888, 17368.305267789307, 1451.3251338127768, 1453.607525967988, 1487.1077353587868, 5471.562275017999, 5648.774049038034, 4030.2745505808944, 5520.834374968757, 5880.647161170344, 6159.722812473449, 6162.1681073055015, 5948.0, 6140.201773769404, 6216.129741836146, 6232.345603711613, 6267.686615669221, 6012.6392416455155, 6024.518038556905, 6037.245344331958, 6067.423594758491, 6069.150318955328, 5079.187330027215, 5307.628466007381, 5308.734563271821, 5308.92036619451, 5309.469053094698, 12151.513939442411, 13712.862871371259, 19391.4182574523, 19906.0, 19907.203711851507, 1903.4670292318174, 2002.4293076473282, 2400.939976500584, 2486.117428312959, 2800.1459554835765, 9377.671781487616, 9531.332806703533, 9790.657326993522, 10863.239573229877, 13246.933765331209, 1844.8524118070657, 1884.3593178319438, 1888.9055547222583, 1890.432870138953, 1922.1158267197106, 56888.715556422365, 58525.70737146329, 61235.69382153105, 62086.0, 63397.36602633961, 10069.848952265722, 10096.14182794456, 10140.49297535135, 10178.338408003456, 10276.280660353854, 13166.407511661999, 13584.93207533956, 13603.591892243248, 13609.795853062213, 13615.659608509668, 7152.642367881585, 7361.8159546011775, 7365.7790266292095, 7379.298966598165, 7424.183339832614, 7084.256153103953, 7098.893516597255, 7124.358807707331, 7161.104861892263, 7162.0, 4100.507939047334, 4380.277254253013, 4457.888552786207, 4467.977660111744, 4579.885502862455, 1794.9371771988178, 1842.6130512592238, 1847.251862995462, 1854.147092337513, 1868.3091801919286, 887.600579739107, 934.3739694404765, 967.0, 1012.3875055591409, 1093.6117678224275, 12870.67823304425, 15238.771418428732, 15775.946821305432, 15997.600059998593, 16908.746368804477, 830.2647466794429, 923.8198551282435, 933.9719808405758, 950.6767698982379, 1003.5283416794096, 9274.95362523183, 9457.621695132255, 9547.188488978376, 9677.516124193762, 9722.611095556098, 352662.0, 353819.0, 356731.5431879615, 377833.0, 410137.0, 71554.0, 72257.0, 72703.2729672707, 72985.6350718243, 75277.0, 1126.1328776841785, 1127.4588197665003, 1131.4116659337262, 1154.284343706907, 1160.3733983648904, 15656.92171539135, 15721.764173537635, 15742.449014284903, 15751.527454176394, 16005.199740013186, 33640.66359336375, 33672.3265534683, 33962.66037339595, 34766.65233347634, 35486.645133548336, 44414.555854441045, 44829.0, 44846.3273050911, 44917.550824492646, 49237.0, 6763.222229443677, 7707.614619269127, 7815.14033456308, 7876.56678882667, 7888.881666775118, 10336.483175841027, 11568.24806387582, 11891.405429728306, 12106.273623582612, 12259.816102758288, 9686.564104615169, 9909.55407006672, 9925.17682528108, 10198.541065651914, 10251.794964100825, 10366.948165259126, 10372.792544149226, 10532.736681583021, 10624.893751062391, 10685.305455145392, 9769.16962058233, 10059.446730429603, 10126.949365253127, 10328.173746100445, 10346.793064138525, 7745.0, 7766.844663106819, 7800.765977020698, 7877.7636670899965, 7885.053793544811, 8446.197611226924, 10359.32664376813, 10490.947545262225, 10709.357438553712, 10765.515551800032], "unit": "score", "name": "jquery.html", "value": 8180.191869017948}, {"lowerIsBetter": false, "replicates": [1292.5476083370816, 1477.8226612806463, 1500.077452366794, 1702.6850032743944, 1848.5933094719167, 7377.188509263977, 7873.488223265484, 8022.277994980451, 8027.799305017377, 8035.437519373653, 7590.316871481566, 7769.417293702981, 7788.688452461909, 7794.649240784164, 7806.531608103518, 1898.392514395394, 1934.1586409911663, 2209.574824238365, 2220.7224096987875, 2233.698450709158, 2274.0, 2282.6347784354507, 2283.954320913581, 2284.1776960294283, 2284.8629082255034, 2177.3359125466727, 2250.6173950428383, 2268.0134141648437, 2268.8184945204343, 2272.329662749493, 2091.592139532799, 2151.3653472225733, 2162.6755986602134, 2184.213683074092, 2190.266260802633, 2204.437868343562, 2231.8214542836695, 2242.5627002734473, 2249.8312626553075, 2252.1779550464125, 8192.795180120485, 8294.958525207396, 8302.211289927447, 8314.459560128573, 8315.168483151698, 4653.627709783209, 4760.190767569521, 4785.019071090418, 4813.109574728652, 4816.397950256218, 2836.1349788314556, 2957.423302456022, 2977.5384815353436, 3014.351914338428, 3023.9546406803697, 944.1691311645708, 950.144869617343, 968.91279784819, 992.4343124419084, 1018.872640919885, 11311.886881131166, 11419.600313989054, 11439.256448330832, 11500.194986350958, 11541.826872596834, 4003.559608443069, 4035.112275299488, 4158.688098392633, 4159.313713237282, 4166.8749937501925, 8994.550272486349, 9063.728088157366, 9192.81614367709, 9193.850768653918, 9214.078592140731, 4689.835855745033, 4734.502877197913, 4760.428748550127, 4764.047190561832, 4765.189917713997, 4390.846320378771, 4401.207782599163, 4402.449693788277, 4403.053343531156, 4406.581374769392, 3266.6896644818703, 3379.121428428626, 3427.537282466835, 3501.492283618861, 3501.824908754552, 1021.97445063874, 1034.255336157965, 1036.1296510930704, 1069.994650026745, 1072.5816931396762, 1302.1275745250516, 1321.6497628128554, 1337.1041402260314, 1347.818044563991, 1356.071091302461, 7566.772996810105, 7594.658240379196, 7605.923940760522, 7611.923880761232, 7659.502132361378, 1085.3704851186294, 1099.4502748625687, 1102.311055590256, 1113.1762495753246, 1138.3966497756203, 5996.16053752475, 6198.380161983856, 6206.0, 6207.6585787782105, 6223.190985171898, 9858.359206651545, 10315.84526232107, 10321.896781032243, 10336.948315258525, 10339.534720937576, 10022.398656080659, 10248.743781405525, 10250.179985601135, 10262.486875656188, 10306.948465257627, 7345.926540734631, 7480.9625951870985, 7521.285477879593, 7522.811929701801, 7532.510386824729, 7685.581664926101, 7739.110002349802, 7777.650005749641, 7828.960855195687, 7850.921490785019, 9009.684661036832, 9138.817223655356, 9258.814823703622, 9333.0, 9345.205657518914, 9427.764305892408, 9490.383125096847, 9581.904180958101, 9588.616455341707, 9719.805603888024, 6857.622830744357, 6963.8607227854145, 6965.47758918073, 6966.338197871194, 6975.128108986377, 6972.860542789014, 7474.476786625101, 7774.572398518136, 7782.610869456391, 7807.141214466517, 7181.569105853457, 7334.559926404433, 7358.411327093927, 7363.631818408951, 7496.58768767723, 7269.164046134762, 7286.453515986216, 7300.123985121607, 7398.815029624302, 7425.368843648351, 7129.857402851811, 7148.28517148281, 7155.105611798525, 7184.748533801292, 7313.597752123685, 6830.419414349836, 6906.240313565403, 6928.722851086101, 6939.826504337432, 6942.583444993316, 6961.0, 6993.510454268152, 7018.543794653331, 7042.859142817218, 7047.15434147885], "unit": "score", "name": "mootools.html", "value": 4588.942333454403}, {"lowerIsBetter": false, "replicates": [332.18283023761546, 338.7781003442745, 341.44685609312916, 346.99826500867493, 351.1081852095677, 5814.156947242653, 5858.648481091132, 5916.4970977466855, 5923.259592550931, 5953.672548009858, 5828.038373668351, 5835.737391817368, 5838.065909454488, 5840.328362238344, 5850.6782126983, 4506.143832671798, 4581.5647513486165, 4582.9541704583025, 4585.610223131038, 4587.632989360844, 4552.704074235181, 4580.97709511452, 4584.885377865547, 4591.79336929839, 4592.954070459303, 4536.841210557631, 4538.251188553884, 4545.318202269653, 4549.522300158485, 4550.385697930787, 4293.828246870122, 4383.167198232358, 4443.4445694288215, 4537.795799189044, 4538.546145385451, 3996.0609256824623, 4011.2579172853116, 4026.879193624167, 4030.4558884550797, 4033.072393349517, 5582.827606202703, 5585.357683866367, 5598.300212473441, 5601.29983752031, 5617.185508101344, 4959.132151873444, 5056.74716264189, 5140.254663073871, 5234.607404444644, 5235.188545775411, 6109.786157484511, 6120.663363515005, 6124.1732366130445, 6139.416755408229, 6141.324454310023, 4405.140997505488, 4406.823727050914, 4439.067795762894, 4440.644748420119, 4451.287793952984, 6342.270638876542, 6427.485801135898, 6494.025896115573, 6508.121403610499, 6508.772192973271, 4545.4545454545005, 4553.681242313006, 4554.294084416921, 4556.179887620194, 4560.68075234737, 4612.123696497655, 4616.95383046172, 4618.237990731492, 4618.422697162855, 4619.076184763061, 5260.395054568774, 5264.789408423697, 5265.526102650703, 5266.262723218752, 5268.947310526845, 6055.909161362583, 6226.25284965807, 6227.657478838707, 6234.220722409699, 6248.968920128128, 1617.4581515192308, 1645.843644853737, 1647.2998975435391, 1647.637519745678, 1650.7853978982655, 1102.862142232221, 1104.5636973395465, 1124.3029321820525, 1124.8931351521592, 1143.816989281711, 5991.910121348184, 5997.400259973968, 5999.4900433463645, 6000.759969601254, 6004.3395226525045, 6451.032345148265, 6453.032045193258, 6461.0631458438265, 6463.741450342028, 6465.030245463124, 5960.0761881908375, 5989.730462129215, 5993.970030149909, 5994.07091900756, 6003.3996600339615, 3392.6437724039115, 3512.9824350878084, 3516.1385460562324, 3516.82415879205, 3521.4893840393, 6786.049953006583, 6800.31996800316, 6808.659567021629, 6812.693428795617, 6813.3527314905, 6323.241211054611, 6526.477881769447, 6644.568103073285, 6659.134312539339, 6660.0, 6761.256261811295, 6781.898271525833, 6787.5588086774205, 6792.558483698544, 6805.727770889208, 6506.154199953976, 6509.283978762238, 6510.44661203803, 6513.641749703812, 6516.1980348450625, 6307.0, 6402.647854368054, 6407.679616019087, 6411.198600174978, 6424.807255782334, 6778.525503214728, 6780.762673306411, 6788.389044985975, 6792.286809884891, 6797.490188236001, 4449.421575195204, 4475.641948644035, 4478.977605111953, 4482.215612267905, 4485.48416932044, 6380.266269379081, 6502.772402965874, 6506.349365063646, 6510.967445162744, 6513.609183449008, 6288.056791481132, 6292.779752708633, 6339.302676705466, 6349.206349206349, 6355.968220158869, 6269.404406581368, 6314.589551679126, 6315.936840631535, 6319.083732858801, 6343.5876668016435, 6074.088886667036, 6220.440160385587, 6226.470749986121, 6231.594946328474, 6238.095476156022, 6367.777127800505, 6374.490040796818, 6380.7447702091395, 6385.96807015962, 6386.776462823779, 6219.378062193925, 6221.564490485623, 6222.191115155001, 6225.906611400923, 6231.813045608639], "unit": "score", "name": "prototype.html", "value": 4761.800355906366}, {"lowerIsBetter": false, "replicates": [782.0447293857277, 806.7216810200482, 810.5744484145823, 814.0963530481168, 817.7046502594542, 13368.933155334222, 13482.595522134327, 13523.729525409486, 13568.118072325293, 13599.45602175913, 12955.611331660042, 13100.672483187902, 13123.475060997549, 13141.408636611352, 13237.80143297849, 659.1661548141604, 670.1422179610107, 792.3700657976893, 800.9959950200241, 801.6873419366452, 803.1526739290047, 822.8601137806587, 823.5717426937989, 823.6540652925786, 824.5464994253167, 848.9490630562156, 859.7549698335976, 861.4960248254779, 862.2455351567379, 862.6894318045498, 686.8145600687786, 833.5248908122372, 843.9872153415895, 850.6087199888059, 852.6418904060309, 630.7477009196313, 631.7157279224367, 632.5635311634957, 633.3128555517269, 634.7714822663837, 13220.471181152743, 13303.334833258396, 13308.134971226838, 13313.86686133136, 13336.599902002858, 10838.132949364031, 11126.554937802479, 11200.383978881158, 11512.481938312796, 11810.52757889692, 10257.897421025844, 10258.17934565233, 10405.16758659313, 10510.10664093553, 10969.23215374924, 3573.3210689968823, 3642.7814331140216, 3662.7436079474446, 3669.743117981742, 3676.8529258829612, 46303.30545041793, 46447.303290450334, 46472.3029154563, 46712.53287467116, 46874.76562617165, 9257.629694812267, 9532.142107210384, 9578.13796758295, 9635.470049147365, 9656.27577931658, 18582.628347432976, 18614.06929653512, 18632.72050919237, 18660.440186794418, 18662.0, 7462.552246865097, 7609.809754756176, 7618.733344333033, 7705.113911900091, 7740.690372385154, 4261.31818908973, 4280.122574872144, 4285.935710964338, 4312.719673221293, 4438.955610443919, 3000.3849210911712, 3027.909162725122, 3032.651245106841, 3042.0265515035417, 3043.04144194578, 548.9835304940858, 554.3680204566797, 559.8992181407385, 563.9689817060101, 569.3253494608902, 636.4876274598993, 645.5932762359777, 650.6096342194645, 672.6434989455596, 677.1129819935801, 7855.685772569148, 7856.292933636, 7950.1254861965135, 7982.361411087215, 8131.471454355448, 475.1660835234211, 528.6088294661922, 561.9409961953936, 632.4497687012237, 635.841039740065, 3643.872464463731, 3920.941185882214, 4051.8784436466954, 4249.277622804069, 4252.702310838212, 49740.502594974314, 50778.49221507811, 50876.49123508792, 50998.49001510011, 51100.48899511032, 45151.322730159074, 45230.0, 45389.54610453919, 47104.0, 47420.76289618599, 42668.78665606652, 43280.0, 43387.78306108512, 43553.78223108864, 44585.55414445879, 8364.958175209085, 8443.577821109044, 8514.914850851412, 8626.260305919172, 8635.0, 32355.838220808746, 32421.675783241866, 32468.83765581157, 32629.0, 33426.164345890575, 40320.798396007835, 41308.58691413047, 41610.79194604129, 41646.79176604097, 41912.3713144297, 9208.447493150432, 9388.624455021723, 9401.482918439551, 9526.666566670134, 9961.800763984824, 10842.457877105955, 11064.170187235828, 11305.039071678999, 11321.320720756781, 11517.481713322753, 10265.897341026493, 10375.325603835727, 10409.063184313449, 10684.145268378355, 10715.981506934899, 10275.280730348804, 10446.322916302606, 10485.790284194121, 10768.246222764332, 10839.458027098772, 6806.897896531655, 10554.611771759646, 10581.15350771921, 10757.515911784145, 10844.566217351217, 8699.91300086991, 8880.911190888008, 8957.731268061969, 9049.638014479347, 9086.500242486727, 9093.818123637622, 9145.222656074307, 9261.16649501548, 9409.388389754644, 9589.808203836024], "unit": "score", "name": "yui.html", "value": 6050.216610524786}], "name": "dromaeo_css", "value": 6844.533652624444}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 106.0, 110.0, 111.0, 112.0, 101.0, 112.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 109.2}, {"lowerIsBetter": true, "replicates": [154.0, 126.0, 149.0, 169.0, 129.0, 164.0, 155.0, 130.0, 184.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 148.8}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 163.0, 162.0, 161.0, 159.0, 162.0, 163.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.6}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 92.0, 93.0, 73.0, 73.0, 74.0, 128.0, 93.0, 76.0], "unit": "score", "name": "audio-fft", "value": 84.8}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 144.0, 95.0, 96.0, 95.0, 140.0, 95.0, 96.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 109.1}, {"lowerIsBetter": true, "replicates": [119.0, 115.0, 114.0, 115.0, 115.0, 114.0, 114.0, 115.0, 115.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.1}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [54.0, 55.0, 57.0, 53.0, 54.0, 54.0, 57.0, 62.0, 52.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 55.2}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 68.0, 67.0, 68.0, 67.0, 68.0, 67.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.4}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 85.0, 85.0, 86.0, 86.0, 92.0, 86.0, 87.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.2}, {"lowerIsBetter": true, "replicates": [119.0, 117.0, 115.0, 127.0, 113.0, 129.0, 132.0, 126.0, 118.0, 128.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.4}, {"lowerIsBetter": true, "replicates": [152.0, 153.0, 145.0, 151.0, 150.0, 141.0, 150.0, 148.0, 147.0, 154.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.1}, {"lowerIsBetter": true, "replicates": [69.0, 71.0, 70.0, 69.0, 68.0, 67.0, 68.0, 70.0, 68.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.7}], "name": "kraken", "value": 1518.9}]} 09:46:08 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1518.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6844.53"}}} 09:46:08 INFO - Return code: 0 09:46:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 09:46:08 INFO - # TBPL SUCCESS # 09:46:08 INFO - Running post-action listener: _resource_record_post_action 09:46:08 INFO - Running post-run listener: _resource_record_post_run 09:46:09 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 539525120; Read time: 0; Write time: 466088 09:46:09 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 240259072; Read time: 0; Write time: 261904 09:46:09 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 298995712; Read time: 0; Write time: 204168 09:46:09 INFO - Running post-run listener: _upload_blobber_files 09:46:09 INFO - Blob upload gear active. 09:46:09 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 09:46:09 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 09:46:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 09:46:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 09:46:09 INFO - (blobuploader) - INFO - Open directory for files ... 09:46:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 09:46:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:46:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:46:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:46:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:46:11 INFO - (blobuploader) - INFO - Done attempting. 09:46:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:46:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:46:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:46:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:46:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:46:12 INFO - (blobuploader) - INFO - Done attempting. 09:46:12 INFO - (blobuploader) - INFO - Iteration through files over. 09:46:12 INFO - Return code: 0 09:46:12 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 09:46:12 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 09:46:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/09511cbb7bb7f9a877c927254622884de5af3f37e1189eaaef6522a1e481b1a4d7340d10c58e91a1cac4ddd1dc5cb0dac2c3cd42d328e6e6058519f8a7cfce7f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/629472d06249f5530e30b2bb7703c9fa3d55b656678e1341647dc5d5469ec3b6f6e90f5c2d19ada73559bf0d6a9f4752834b0eb07039049d619d638c2fdfea5c"} 09:46:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 09:46:12 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 09:46:12 INFO - Contents: 09:46:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/09511cbb7bb7f9a877c927254622884de5af3f37e1189eaaef6522a1e481b1a4d7340d10c58e91a1cac4ddd1dc5cb0dac2c3cd42d328e6e6058519f8a7cfce7f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/629472d06249f5530e30b2bb7703c9fa3d55b656678e1341647dc5d5469ec3b6f6e90f5c2d19ada73559bf0d6a9f4752834b0eb07039049d619d638c2fdfea5c"} 09:46:12 INFO - Running post-run listener: copy_logs_to_upload_dir 09:46:12 INFO - Copying logs to upload dir... 09:46:12 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 09:46:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.090302 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-02-10 09:46:12.198827) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-10 09:46:12.203022) ========= 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=7de08804244eb36560b44971000001c3-1455125142.48559-1281864518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/09511cbb7bb7f9a877c927254622884de5af3f37e1189eaaef6522a1e481b1a4d7340d10c58e91a1cac4ddd1dc5cb0dac2c3cd42d328e6e6058519f8a7cfce7f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/629472d06249f5530e30b2bb7703c9fa3d55b656678e1341647dc5d5469ec3b6f6e90f5c2d19ada73559bf0d6a9f4752834b0eb07039049d619d638c2fdfea5c"} build_url:https://queue.taskcluster.net/v1/task/bUm4NeltToSNRHrl6TZdUQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011319 build_url: 'https://queue.taskcluster.net/v1/task/bUm4NeltToSNRHrl6TZdUQ/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/Firefox/sha512/09511cbb7bb7f9a877c927254622884de5af3f37e1189eaaef6522a1e481b1a4d7340d10c58e91a1cac4ddd1dc5cb0dac2c3cd42d328e6e6058519f8a7cfce7f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/629472d06249f5530e30b2bb7703c9fa3d55b656678e1341647dc5d5469ec3b6f6e90f5c2d19ada73559bf0d6a9f4752834b0eb07039049d619d638c2fdfea5c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-10 09:46:12.234357) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 09:46:12.234953) ========= 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=7de08804244eb36560b44971000001c3-1455125142.48559-1281864518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004758 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 09:46:12.321003) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-10 09:46:12.321582) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-10 09:46:12.322072) ========= ========= Total master_lag: 0.29 =========