builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-045 starttime: 1455716970.26 results: success (0) buildid: 20160217030229 builduid: 70a81bd2d575445ab0b6bc647acf023a revision: 15621f98b53b1994c7ae2e2703a6e50203c5304c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-17 05:49:30.260679) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-17 05:49:30.261152) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-17 05:49:30.261460) ========= 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=1b9da9da7504fe468691862d000001b9-1455716216.376648-1824933311 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006313 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-17 05:49:30.284783) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-17 05:49:30.285101) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-17 05:49:30.311290) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 05:49:30.311717) ========= 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=1b9da9da7504fe468691862d000001b9-1455716216.376648-1824933311 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.026079 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 05:49:30.359310) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-17 05:49:30.359680) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-17 05:49:30.360049) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 05:49:30.360337) ========= 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=1b9da9da7504fe468691862d000001b9-1455716216.376648-1824933311 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-17 05:49:30-- 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% 218M=0s 2016-02-17 05:49:30 (218 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.159324 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 05:49:30.532085) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 05:49:30.532484) ========= 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=1b9da9da7504fe468691862d000001b9-1455716216.376648-1824933311 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.058721 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 05:49:30.604051) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 05:49:30.604438) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 15621f98b53b1994c7ae2e2703a6e50203c5304c --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 15621f98b53b1994c7ae2e2703a6e50203c5304c --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=1b9da9da7504fe468691862d000001b9-1455716216.376648-1824933311 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-17 05:49:30,732 truncating revision to first 12 chars 2016-02-17 05:49:30,733 Setting DEBUG logging. 2016-02-17 05:49:30,733 attempt 1/10 2016-02-17 05:49:30,733 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/15621f98b53b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-17 05:49:30,998 unpacking tar archive at: mozilla-central-15621f98b53b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.555630 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 05:49:31.174790) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-17 05:49:31.175192) ========= echo 15621f98b53b1994c7ae2e2703a6e50203c5304c in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'15621f98b53b1994c7ae2e2703a6e50203c5304c'] 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=1b9da9da7504fe468691862d000001b9-1455716216.376648-1824933311 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15621f98b53b1994c7ae2e2703a6e50203c5304c program finished with exit code 0 elapsedTime=0.004663 script_repo_revision: '15621f98b53b1994c7ae2e2703a6e50203c5304c' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-17 05:49:31.226349) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-17 05:49:31.226664) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-17 05:49:31.238019) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-02-17 05:49:31.238340) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=1b9da9da7504fe468691862d000001b9-1455716216.376648-1824933311 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:49:31 INFO - MultiFileLogger online at 20160217 05:49:31 in /builds/slave/test-pgo 05:49:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:49:31 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:49:31 INFO - {'append_to_log': False, 05:49:31 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:49:31 INFO - 'blob_upload_branch': 'Firefox', 05:49:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:49:31 INFO - 'branch': 'Firefox', 05:49:31 INFO - 'buildbot_json_path': 'buildprops.json', 05:49:31 INFO - 'config_files': ('talos/linux_config.py',), 05:49:31 INFO - 'default_actions': ('clobber', 05:49:31 INFO - 'read-buildbot-config', 05:49:31 INFO - 'download-and-extract', 05:49:31 INFO - 'populate-webroot', 05:49:31 INFO - 'create-virtualenv', 05:49:31 INFO - 'install', 05:49:31 INFO - 'run-tests'), 05:49:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:49:31 INFO - 'download_minidump_stackwalk': True, 05:49:31 INFO - 'download_symbols': 'ondemand', 05:49:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:49:31 INFO - 'tooltool.py': '/tools/tooltool.py', 05:49:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:49:31 INFO - '/tools/misc-python/virtualenv.py')}, 05:49:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:49:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:49:31 INFO - 'installer_path': 'installer.exe', 05:49:31 INFO - 'log_level': 'info', 05:49:31 INFO - 'log_name': 'talos', 05:49:31 INFO - 'log_to_console': True, 05:49:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:49:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:49:31 INFO - 'opt_config_files': (), 05:49:31 INFO - 'pip_index': False, 05:49:31 INFO - 'sps_profile': False, 05:49:31 INFO - 'sps_profile_interval': 0, 05:49:31 INFO - 'suite': 'dromaeojs-e10s', 05:49:31 INFO - 'system_bits': '32', 05:49:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:49:31 INFO - 'title': 'talos-linux64-ix-045', 05:49:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:49:31 INFO - 'use_talos_json': True, 05:49:31 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:49:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:49:31 INFO - 'work_dir': 'build'} 05:49:31 INFO - ##### 05:49:31 INFO - ##### Running clobber step. 05:49:31 INFO - ##### 05:49:31 INFO - Running pre-action listener: _resource_record_pre_action 05:49:31 INFO - Running main action method: clobber 05:49:31 INFO - rmtree: /builds/slave/test-pgo/build 05:49:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:49:35 INFO - Running post-action listener: _resource_record_post_action 05:49:35 INFO - ##### 05:49:35 INFO - ##### Running read-buildbot-config step. 05:49:35 INFO - ##### 05:49:35 INFO - Running pre-action listener: _resource_record_pre_action 05:49:35 INFO - Running main action method: read_buildbot_config 05:49:35 INFO - Using buildbot properties: 05:49:35 INFO - { 05:49:35 INFO - "project": "", 05:49:35 INFO - "product": "firefox", 05:49:35 INFO - "script_repo_revision": "production", 05:49:35 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:49:35 INFO - "repository": "", 05:49:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:49:35 INFO - "buildid": "20160217030229", 05:49:35 INFO - "stage_platform": "linux64-pgo", 05:49:35 INFO - "basedir": "/builds/slave/test-pgo", 05:49:35 INFO - "nightly_build": "True", 05:49:35 INFO - "buildnumber": 642, 05:49:35 INFO - "slavename": "talos-linux64-ix-045", 05:49:35 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:49:35 INFO - "platform": "ubuntu64_hw", 05:49:35 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:49:35 INFO - "branch": "mozilla-central", 05:49:35 INFO - "repo_path": "mozilla-central", 05:49:35 INFO - "revision": "15621f98b53b1994c7ae2e2703a6e50203c5304c", 05:49:35 INFO - "pgo_build": "True", 05:49:35 INFO - "builduid": "70a81bd2d575445ab0b6bc647acf023a", 05:49:35 INFO - "slavebuilddir": "test" 05:49:35 INFO - } 05:49:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/NJdWzCIQTmeO9x8K7jWXXQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 05:49:35 INFO - Running post-action listener: _resource_record_post_action 05:49:35 INFO - ##### 05:49:35 INFO - ##### Running download-and-extract step. 05:49:35 INFO - ##### 05:49:35 INFO - Running pre-action listener: _resource_record_pre_action 05:49:35 INFO - Running main action method: download_and_extract 05:49:35 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:49:35 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')]} 05:49:35 INFO - https://queue.taskcluster.net/v1/task/NJdWzCIQTmeO9x8K7jWXXQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:49:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJdWzCIQTmeO9x8K7jWXXQ/artifacts/public/build/test_packages.json 05:49:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJdWzCIQTmeO9x8K7jWXXQ/artifacts/public/build/test_packages.json 05:49:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJdWzCIQTmeO9x8K7jWXXQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:49:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJdWzCIQTmeO9x8K7jWXXQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:49:37 INFO - Downloaded 1448 bytes. 05:49:37 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:49:37 INFO - Using the following test package requirements: 05:49:37 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 05:49:37 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:37 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:49:37 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:37 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:49:37 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:37 INFO - u'jsshell-linux-x86_64.zip'], 05:49:37 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:37 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:49:37 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 05:49:37 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:37 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:49:37 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:37 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:49:37 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:37 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:49:37 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 05:49:37 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:37 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:49:37 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:49:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:37 INFO - https://queue.taskcluster.net/v1/task/NJdWzCIQTmeO9x8K7jWXXQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:49:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJdWzCIQTmeO9x8K7jWXXQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:49:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJdWzCIQTmeO9x8K7jWXXQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:49:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJdWzCIQTmeO9x8K7jWXXQ/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 05:49:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJdWzCIQTmeO9x8K7jWXXQ/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 05:49:39 INFO - Downloaded 23345833 bytes. 05:49:39 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'] 05:49:39 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 05:49:40 INFO - Return code: 0 05:49:40 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 05:49:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:40 INFO - https://queue.taskcluster.net/v1/task/NJdWzCIQTmeO9x8K7jWXXQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:49:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJdWzCIQTmeO9x8K7jWXXQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:49:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJdWzCIQTmeO9x8K7jWXXQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:49:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJdWzCIQTmeO9x8K7jWXXQ/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 05:49:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJdWzCIQTmeO9x8K7jWXXQ/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 05:49:50 INFO - Downloaded 23345833 bytes. 05:49:50 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'] 05:49:50 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 05:49:52 INFO - Return code: 0 05:49:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:52 INFO - https://queue.taskcluster.net/v1/task/NJdWzCIQTmeO9x8K7jWXXQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:49:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJdWzCIQTmeO9x8K7jWXXQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 05:49:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJdWzCIQTmeO9x8K7jWXXQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 05:49:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJdWzCIQTmeO9x8K7jWXXQ/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 05:49:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJdWzCIQTmeO9x8K7jWXXQ/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 05:49:53 INFO - Downloaded 10707071 bytes. 05:49:53 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'] 05:49:53 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 05:49:53 INFO - Return code: 0 05:49:53 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')]} 05:49:53 INFO - https://queue.taskcluster.net/v1/task/NJdWzCIQTmeO9x8K7jWXXQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:49:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJdWzCIQTmeO9x8K7jWXXQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:49:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJdWzCIQTmeO9x8K7jWXXQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:49:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJdWzCIQTmeO9x8K7jWXXQ/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 05:49:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJdWzCIQTmeO9x8K7jWXXQ/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 05:49:55 INFO - Downloaded 56576027 bytes. 05:49:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NJdWzCIQTmeO9x8K7jWXXQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:49:55 INFO - mkdir: /builds/slave/test-pgo/properties 05:49:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:49:55 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:49:55 INFO - Contents: 05:49:55 INFO - build_url:https://queue.taskcluster.net/v1/task/NJdWzCIQTmeO9x8K7jWXXQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:49:55 INFO - Running post-action listener: _resource_record_post_action 05:49:55 INFO - Running post-action listener: set_extra_try_arguments 05:49:55 INFO - ##### 05:49:55 INFO - ##### Running populate-webroot step. 05:49:55 INFO - ##### 05:49:55 INFO - Running pre-action listener: _resource_record_pre_action 05:49:55 INFO - Running main action method: populate_webroot 05:49:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:49:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:49:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:49:55 INFO - '--tppagecycles', 05:49:55 INFO - '7'], 05:49:55 INFO - 'tests': ['tsvgm']}}, 05:49:55 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:49:55 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:49:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:49:55 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:49:55 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:49:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:49:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:49:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:55 INFO - 'talos_options': ['--e10s'], 05:49:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:49:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:55 INFO - 'tests': ['damp', 'tps']}, 05:49:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:55 INFO - 'talos_options': ['--e10s'], 05:49:55 INFO - 'tests': ['damp', 'tps']}, 05:49:55 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:49:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:49:55 INFO - 'other': {'tests': ['a11yr', 05:49:55 INFO - 'ts_paint', 05:49:55 INFO - 'tpaint', 05:49:55 INFO - 'sessionrestore', 05:49:55 INFO - 'sessionrestore_no_auto_restore']}, 05:49:55 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:49:55 INFO - 'tests': ['a11yr', 05:49:55 INFO - 'ts_paint', 05:49:55 INFO - 'tpaint', 05:49:55 INFO - 'sessionrestore', 05:49:55 INFO - 'sessionrestore_no_auto_restore']}, 05:49:55 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:49:55 INFO - 'tests': ['a11yr', 05:49:55 INFO - 'ts_paint', 05:49:55 INFO - 'tpaint', 05:49:55 INFO - 'sessionrestore', 05:49:55 INFO - 'sessionrestore_no_auto_restore']}, 05:49:55 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:49:55 INFO - 'tests': ['a11yr', 05:49:55 INFO - 'ts_paint', 05:49:55 INFO - 'tpaint', 05:49:55 INFO - 'sessionrestore', 05:49:55 INFO - 'sessionrestore_no_auto_restore']}, 05:49:55 INFO - 'other_l64': {'tests': ['a11yr', 05:49:55 INFO - 'ts_paint', 05:49:55 INFO - 'tpaint', 05:49:55 INFO - 'sessionrestore', 05:49:55 INFO - 'sessionrestore_no_auto_restore']}, 05:49:55 INFO - 'other_nol64': {'tests': ['a11yr', 05:49:55 INFO - 'ts_paint', 05:49:55 INFO - 'tpaint', 05:49:55 INFO - 'sessionrestore', 05:49:55 INFO - 'sessionrestore_no_auto_restore']}, 05:49:55 INFO - 'svgr': {'tests': ['tsvgx', 05:49:55 INFO - 'tsvgr_opacity', 05:49:55 INFO - 'tart', 05:49:55 INFO - 'tscrollx', 05:49:55 INFO - 'cart']}, 05:49:55 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:49:55 INFO - 'tests': ['tsvgx', 05:49:55 INFO - 'tsvgr_opacity', 05:49:55 INFO - 'tart', 05:49:55 INFO - 'tscrollx', 05:49:55 INFO - 'cart']}, 05:49:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:55 INFO - 'tests': ['tp5o']}, 05:49:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:55 INFO - 'talos_options': ['--e10s'], 05:49:55 INFO - 'tests': ['tp5o']}, 05:49:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:55 INFO - 'talos_options': ['--xperf_path', 05:49:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:49:55 INFO - 'tests': ['tp5n']}, 05:49:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:55 INFO - 'talos_options': ['--e10s', 05:49:55 INFO - '--xperf_path', 05:49:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:49:55 INFO - 'tests': ['tp5n']}}, 05:49:55 INFO - 'talos.zip': {'path': '', 05:49:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:49:55 INFO - Running post-action listener: _resource_record_post_action 05:49:55 INFO - ##### 05:49:55 INFO - ##### Running create-virtualenv step. 05:49:55 INFO - ##### 05:49:55 INFO - Running pre-action listener: _resource_record_pre_action 05:49:55 INFO - Running main action method: create_virtualenv 05:49:55 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:49:55 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 05:49:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:49:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:49:55 INFO - Using real prefix '/usr' 05:49:55 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:49:56 INFO - Installing distribute.............................................................................................................................................................................................done. 05:49:58 INFO - Installing pip.................done. 05:49:58 INFO - Return code: 0 05:49:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:49:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f788ad08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2143670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d28c0>, '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 0x21d37c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d3c50>, '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': '1b9da9da7504fe468691862d000001b9-1455716216.376648-1824933311', '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 05:49:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 05:49:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:49:58 INFO - Using env: {'DISPLAY': ':0', 05:49:58 INFO - 'HOME': '/home/cltbld', 05:49:58 INFO - 'LANG': 'en_US.UTF-8', 05:49:58 INFO - 'LANGUAGE': 'en_US:en', 05:49:58 INFO - 'LOGNAME': 'cltbld', 05:49:58 INFO - 'MAIL': '/var/mail/cltbld', 05:49:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:58 INFO - 'MOZ_NO_REMOTE': '1', 05:49:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:58 INFO - 'NO_EM_RESTART': '1', 05:49:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:49:58 INFO - 'PWD': '/builds/slave/test-pgo', 05:49:58 INFO - 'SHELL': '/bin/bash', 05:49:58 INFO - 'SHLVL': '1', 05:49:58 INFO - 'TERM': 'linux', 05:49:58 INFO - 'TMOUT': '86400', 05:49:58 INFO - 'USER': 'cltbld', 05:49:58 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1455716216.376648-1824933311', 05:49:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:58 INFO - '_': '/tools/buildbot/bin/python'} 05:49:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:58 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:49:58 INFO - Cleaning up... 05:49:58 INFO - Return code: 0 05:49:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:49:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f788ad08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2143670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d28c0>, '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 0x21d37c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d3c50>, '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': '1b9da9da7504fe468691862d000001b9-1455716216.376648-1824933311', '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 05:49:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:49:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:49:58 INFO - Using env: {'DISPLAY': ':0', 05:49:58 INFO - 'HOME': '/home/cltbld', 05:49:58 INFO - 'LANG': 'en_US.UTF-8', 05:49:58 INFO - 'LANGUAGE': 'en_US:en', 05:49:58 INFO - 'LOGNAME': 'cltbld', 05:49:58 INFO - 'MAIL': '/var/mail/cltbld', 05:49:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:58 INFO - 'MOZ_NO_REMOTE': '1', 05:49:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:58 INFO - 'NO_EM_RESTART': '1', 05:49:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:49:58 INFO - 'PWD': '/builds/slave/test-pgo', 05:49:58 INFO - 'SHELL': '/bin/bash', 05:49:58 INFO - 'SHLVL': '1', 05:49:58 INFO - 'TERM': 'linux', 05:49:58 INFO - 'TMOUT': '86400', 05:49:58 INFO - 'USER': 'cltbld', 05:49:58 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1455716216.376648-1824933311', 05:49:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:58 INFO - '_': '/tools/buildbot/bin/python'} 05:49:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:58 INFO - Downloading/unpacking psutil>=0.7.1 05:49:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:50:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:50:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:50:00 INFO - Installing collected packages: psutil 05:50:00 INFO - Running setup.py install for psutil 05:50:00 INFO - building 'psutil._psutil_linux' extension 05:50:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:50:00 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 05:50:00 INFO - building 'psutil._psutil_posix' extension 05:50:00 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 05:50:01 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:50:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:50:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:50:01 INFO - Successfully installed psutil 05:50:01 INFO - Cleaning up... 05:50:01 INFO - Return code: 0 05:50:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:50:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f788ad08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2143670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d28c0>, '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 0x21d37c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d3c50>, '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': '1b9da9da7504fe468691862d000001b9-1455716216.376648-1824933311', '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 05:50:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 05:50:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:50:01 INFO - Using env: {'DISPLAY': ':0', 05:50:01 INFO - 'HOME': '/home/cltbld', 05:50:01 INFO - 'LANG': 'en_US.UTF-8', 05:50:01 INFO - 'LANGUAGE': 'en_US:en', 05:50:01 INFO - 'LOGNAME': 'cltbld', 05:50:01 INFO - 'MAIL': '/var/mail/cltbld', 05:50:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:01 INFO - 'MOZ_NO_REMOTE': '1', 05:50:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:01 INFO - 'NO_EM_RESTART': '1', 05:50:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:50:01 INFO - 'PWD': '/builds/slave/test-pgo', 05:50:01 INFO - 'SHELL': '/bin/bash', 05:50:01 INFO - 'SHLVL': '1', 05:50:01 INFO - 'TERM': 'linux', 05:50:01 INFO - 'TMOUT': '86400', 05:50:01 INFO - 'USER': 'cltbld', 05:50:01 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1455716216.376648-1824933311', 05:50:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:01 INFO - '_': '/tools/buildbot/bin/python'} 05:50:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:50:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:50:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:50:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:50:03 INFO - Installing collected packages: mozsystemmonitor 05:50:03 INFO - Running setup.py install for mozsystemmonitor 05:50:03 INFO - Successfully installed mozsystemmonitor 05:50:03 INFO - Cleaning up... 05:50:03 INFO - Return code: 0 05:50:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:50:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f788ad08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2143670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d28c0>, '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 0x21d37c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d3c50>, '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': '1b9da9da7504fe468691862d000001b9-1455716216.376648-1824933311', '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 05:50:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 05:50:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:50:03 INFO - Using env: {'DISPLAY': ':0', 05:50:03 INFO - 'HOME': '/home/cltbld', 05:50:03 INFO - 'LANG': 'en_US.UTF-8', 05:50:03 INFO - 'LANGUAGE': 'en_US:en', 05:50:03 INFO - 'LOGNAME': 'cltbld', 05:50:03 INFO - 'MAIL': '/var/mail/cltbld', 05:50:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:03 INFO - 'MOZ_NO_REMOTE': '1', 05:50:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:03 INFO - 'NO_EM_RESTART': '1', 05:50:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:50:03 INFO - 'PWD': '/builds/slave/test-pgo', 05:50:03 INFO - 'SHELL': '/bin/bash', 05:50:03 INFO - 'SHLVL': '1', 05:50:03 INFO - 'TERM': 'linux', 05:50:03 INFO - 'TMOUT': '86400', 05:50:03 INFO - 'USER': 'cltbld', 05:50:03 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1455716216.376648-1824933311', 05:50:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:03 INFO - '_': '/tools/buildbot/bin/python'} 05:50:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:03 INFO - Downloading/unpacking blobuploader==1.2.4 05:50:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:05 INFO - Downloading blobuploader-1.2.4.tar.gz 05:50:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:50:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:50:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:50:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:50:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:06 INFO - Downloading docopt-0.6.1.tar.gz 05:50:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:50:06 INFO - Installing collected packages: blobuploader, requests, docopt 05:50:06 INFO - Running setup.py install for blobuploader 05:50:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:50:06 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:50:06 INFO - Running setup.py install for requests 05:50:06 INFO - Running setup.py install for docopt 05:50:06 INFO - Successfully installed blobuploader requests docopt 05:50:06 INFO - Cleaning up... 05:50:06 INFO - Return code: 0 05:50:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:50:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:06 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 0x7f788ad08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2143670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d28c0>, '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 0x21d37c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d3c50>, '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': '1b9da9da7504fe468691862d000001b9-1455716216.376648-1824933311', '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 05:50:06 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 05:50:06 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 05:50:06 INFO - Using env: {'DISPLAY': ':0', 05:50:06 INFO - 'HOME': '/home/cltbld', 05:50:06 INFO - 'LANG': 'en_US.UTF-8', 05:50:06 INFO - 'LANGUAGE': 'en_US:en', 05:50:06 INFO - 'LOGNAME': 'cltbld', 05:50:06 INFO - 'MAIL': '/var/mail/cltbld', 05:50:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:06 INFO - 'MOZ_NO_REMOTE': '1', 05:50:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:06 INFO - 'NO_EM_RESTART': '1', 05:50:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:50:06 INFO - 'PWD': '/builds/slave/test-pgo', 05:50:06 INFO - 'SHELL': '/bin/bash', 05:50:06 INFO - 'SHLVL': '1', 05:50:06 INFO - 'TERM': 'linux', 05:50:06 INFO - 'TMOUT': '86400', 05:50:06 INFO - 'USER': 'cltbld', 05:50:06 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1455716216.376648-1824933311', 05:50:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:06 INFO - '_': '/tools/buildbot/bin/python'} 05:50:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:50:07 INFO - Running setup.py (path:/tmp/pip-Ip911O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:50:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:50:07 INFO - Running setup.py (path:/tmp/pip-Gqjf4f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:50:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:50:07 INFO - Running setup.py (path:/tmp/pip-eoYRLp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:50:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:50:07 INFO - Running setup.py (path:/tmp/pip-Pu3vzC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:50:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:50:07 INFO - Running setup.py (path:/tmp/pip-kQaLBD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:50:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:50:07 INFO - Running setup.py (path:/tmp/pip-Ofkr1Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:50:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:50:07 INFO - Running setup.py (path:/tmp/pip-38Xz6M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:50:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:50:07 INFO - Running setup.py (path:/tmp/pip-xTi1L6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:50:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:50:07 INFO - Running setup.py (path:/tmp/pip-W5055Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:50:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:50:07 INFO - Running setup.py (path:/tmp/pip-lZAmMM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:50:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:50:07 INFO - Running setup.py (path:/tmp/pip-_jdD9F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:50:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:50:07 INFO - Running setup.py (path:/tmp/pip-GOFuxc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:50:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:50:08 INFO - Running setup.py (path:/tmp/pip-rnGmKs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:50:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:50:08 INFO - Running setup.py (path:/tmp/pip-UOxLYU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:50:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:50:08 INFO - Running setup.py (path:/tmp/pip-EUF4SE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:50:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:50:08 INFO - Running setup.py (path:/tmp/pip-d2j15z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:50:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:50:08 INFO - Running setup.py (path:/tmp/pip-GPcU6Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:50:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:50:08 INFO - Running setup.py install for manifestparser 05:50:08 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:50:08 INFO - Running setup.py install for mozcrash 05:50:08 INFO - Running setup.py install for mozdebug 05:50:08 INFO - Running setup.py install for mozdevice 05:50:08 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:50:08 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:50:08 INFO - Running setup.py install for mozfile 05:50:08 INFO - Running setup.py install for mozhttpd 05:50:09 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:50:09 INFO - Running setup.py install for mozinfo 05:50:09 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:50:09 INFO - Running setup.py install for mozInstall 05:50:09 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:50:09 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:50:09 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:50:09 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:50:09 INFO - Running setup.py install for mozleak 05:50:09 INFO - Running setup.py install for mozlog 05:50:09 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:50:09 INFO - Running setup.py install for moznetwork 05:50:09 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:50:09 INFO - Running setup.py install for mozprocess 05:50:09 INFO - Running setup.py install for mozprofile 05:50:09 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:50:09 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:50:09 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:50:09 INFO - Running setup.py install for mozrunner 05:50:09 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:50:09 INFO - Running setup.py install for mozscreenshot 05:50:09 INFO - Running setup.py install for moztest 05:50:10 INFO - Running setup.py install for mozversion 05:50:10 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:50:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:50:10 INFO - Cleaning up... 05:50:10 INFO - Return code: 0 05:50:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:50:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f788ad08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2143670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d28c0>, '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 0x21d37c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d3c50>, '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': '1b9da9da7504fe468691862d000001b9-1455716216.376648-1824933311', '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 05:50:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:50:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:50:10 INFO - Using env: {'DISPLAY': ':0', 05:50:10 INFO - 'HOME': '/home/cltbld', 05:50:10 INFO - 'LANG': 'en_US.UTF-8', 05:50:10 INFO - 'LANGUAGE': 'en_US:en', 05:50:10 INFO - 'LOGNAME': 'cltbld', 05:50:10 INFO - 'MAIL': '/var/mail/cltbld', 05:50:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:10 INFO - 'MOZ_NO_REMOTE': '1', 05:50:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:10 INFO - 'NO_EM_RESTART': '1', 05:50:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:50:10 INFO - 'PWD': '/builds/slave/test-pgo', 05:50:10 INFO - 'SHELL': '/bin/bash', 05:50:10 INFO - 'SHLVL': '1', 05:50:10 INFO - 'TERM': 'linux', 05:50:10 INFO - 'TMOUT': '86400', 05:50:10 INFO - 'USER': 'cltbld', 05:50:10 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1455716216.376648-1824933311', 05:50:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:10 INFO - '_': '/tools/buildbot/bin/python'} 05:50:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:50:10 INFO - Running setup.py (path:/tmp/pip-qgcJZ5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:50:10 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 05:50:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:50:10 INFO - Running setup.py (path:/tmp/pip-aKM3mT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:50:10 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)) 05:50:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:50:10 INFO - Running setup.py (path:/tmp/pip-Zj690q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:50:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:50:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:50:10 INFO - Running setup.py (path:/tmp/pip-XdtyMn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:50:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:50:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:50:10 INFO - Running setup.py (path:/tmp/pip-k6bl_6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:50:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 05:50:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:50:10 INFO - Running setup.py (path:/tmp/pip-eALSE7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:50:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 05:50:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:50:10 INFO - Running setup.py (path:/tmp/pip-IM73bk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:50:10 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)) 05:50:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:50:10 INFO - Running setup.py (path:/tmp/pip-hzyS3o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:50:10 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)) 05:50:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:50:10 INFO - Running setup.py (path:/tmp/pip-a4RLoB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:50:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 05:50:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:50:11 INFO - Running setup.py (path:/tmp/pip-fVtuUh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:50:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:50:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:50:11 INFO - Running setup.py (path:/tmp/pip-XNY815-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:50:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 05:50:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:50:11 INFO - Running setup.py (path:/tmp/pip-QnvUbG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:50:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 05:50:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:50:11 INFO - Running setup.py (path:/tmp/pip-rGGGqI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:50:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 05:50:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:50:11 INFO - Running setup.py (path:/tmp/pip-r5_Vwr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:50:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 05:50:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:50:11 INFO - Running setup.py (path:/tmp/pip-6jr6xR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:50:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 05:50:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:50:11 INFO - Running setup.py (path:/tmp/pip-L90m5x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:50:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 05:50:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:50:11 INFO - Running setup.py (path:/tmp/pip-kDZVF0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:50:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 05:50:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:50:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:50:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:50:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:50:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:50:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:50:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:13 INFO - Downloading blessings-1.6.tar.gz 05:50:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:50:13 INFO - Installing collected packages: blessings 05:50:13 INFO - Running setup.py install for blessings 05:50:13 INFO - Successfully installed blessings 05:50:13 INFO - Cleaning up... 05:50:13 INFO - Return code: 0 05:50:13 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:50:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:50:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:50:13 INFO - Reading from file tmpfile_stdout 05:50:13 INFO - Current package versions: 05:50:13 INFO - argparse == 1.2.1 05:50:13 INFO - blessings == 1.6 05:50:13 INFO - blobuploader == 1.2.4 05:50:13 INFO - docopt == 0.6.1 05:50:13 INFO - manifestparser == 1.1 05:50:13 INFO - mozInstall == 1.12 05:50:13 INFO - mozcrash == 0.16 05:50:13 INFO - mozdebug == 0.1 05:50:13 INFO - mozdevice == 0.48 05:50:13 INFO - mozfile == 1.2 05:50:13 INFO - mozhttpd == 0.7 05:50:13 INFO - mozinfo == 0.9 05:50:13 INFO - mozleak == 0.1 05:50:13 INFO - mozlog == 3.1 05:50:13 INFO - moznetwork == 0.27 05:50:13 INFO - mozprocess == 0.22 05:50:13 INFO - mozprofile == 0.28 05:50:13 INFO - mozrunner == 6.11 05:50:13 INFO - mozscreenshot == 0.1 05:50:13 INFO - mozsystemmonitor == 0.0 05:50:13 INFO - moztest == 0.7 05:50:13 INFO - mozversion == 1.4 05:50:13 INFO - psutil == 3.1.1 05:50:13 INFO - requests == 1.2.3 05:50:13 INFO - wsgiref == 0.1.2 05:50:13 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:50:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:13 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 0x7f788ad08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2143670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d28c0>, '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 0x21d37c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d3c50>, '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': '1b9da9da7504fe468691862d000001b9-1455716216.376648-1824933311', '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 05:50:13 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 05:50:13 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 05:50:13 INFO - Using env: {'DISPLAY': ':0', 05:50:13 INFO - 'HOME': '/home/cltbld', 05:50:13 INFO - 'LANG': 'en_US.UTF-8', 05:50:13 INFO - 'LANGUAGE': 'en_US:en', 05:50:13 INFO - 'LOGNAME': 'cltbld', 05:50:13 INFO - 'MAIL': '/var/mail/cltbld', 05:50:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:13 INFO - 'MOZ_NO_REMOTE': '1', 05:50:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:13 INFO - 'NO_EM_RESTART': '1', 05:50:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:50:13 INFO - 'PWD': '/builds/slave/test-pgo', 05:50:13 INFO - 'SHELL': '/bin/bash', 05:50:13 INFO - 'SHLVL': '1', 05:50:13 INFO - 'TERM': 'linux', 05:50:13 INFO - 'TMOUT': '86400', 05:50:13 INFO - 'USER': 'cltbld', 05:50:13 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1455716216.376648-1824933311', 05:50:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:13 INFO - '_': '/tools/buildbot/bin/python'} 05:50:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:50:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 05:50:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 05:50:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:50:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 05:50:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 05:50:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 05:50:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 05:50:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 05:50:14 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:50:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:50:14 INFO - Cleaning up... 05:50:14 INFO - Return code: 0 05:50:14 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:50: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')]} 05:50:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50: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')]} 05:50:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:14 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f788ad08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2143670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d28c0>, '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 0x21d37c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d3c50>, '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': '1b9da9da7504fe468691862d000001b9-1455716216.376648-1824933311', '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 05:50:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 05:50:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:50:14 INFO - Using env: {'DISPLAY': ':0', 05:50:14 INFO - 'HOME': '/home/cltbld', 05:50:14 INFO - 'LANG': 'en_US.UTF-8', 05:50:14 INFO - 'LANGUAGE': 'en_US:en', 05:50:14 INFO - 'LOGNAME': 'cltbld', 05:50:14 INFO - 'MAIL': '/var/mail/cltbld', 05:50:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:14 INFO - 'MOZ_NO_REMOTE': '1', 05:50:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:14 INFO - 'NO_EM_RESTART': '1', 05:50:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:50:14 INFO - 'PWD': '/builds/slave/test-pgo', 05:50:14 INFO - 'SHELL': '/bin/bash', 05:50:14 INFO - 'SHLVL': '1', 05:50:14 INFO - 'TERM': 'linux', 05:50:14 INFO - 'TMOUT': '86400', 05:50:14 INFO - 'USER': 'cltbld', 05:50:14 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1455716216.376648-1824933311', 05:50:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:14 INFO - '_': '/tools/buildbot/bin/python'} 05:50:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:14 INFO - Downloading/unpacking jsonschema 05:50: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 05:50: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 05:50: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 05:50: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 05:50: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 05:50: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 05:50:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:50:16 INFO - Downloading/unpacking functools32 (from jsonschema) 05:50: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 05:50: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 05:50: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 05:50: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 05:50: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 05:50: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 05:50:16 INFO - Downloading functools32-3.2.3-2.tar.gz 05:50:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:50:16 INFO - warning: no files found matching '*.txt' 05:50:16 INFO - no previously-included directories found matching 'build' 05:50:16 INFO - no previously-included directories found matching 'dist' 05:50:16 INFO - no previously-included directories found matching '.git*' 05:50:16 INFO - Installing collected packages: jsonschema, functools32 05:50:16 INFO - Running setup.py install for functools32 05:50:16 INFO - warning: no files found matching '*.txt' 05:50:16 INFO - no previously-included directories found matching 'build' 05:50:16 INFO - no previously-included directories found matching 'dist' 05:50:16 INFO - no previously-included directories found matching '.git*' 05:50:16 INFO - Successfully installed jsonschema functools32 05:50:16 INFO - Cleaning up... 05:50:16 INFO - Return code: 0 05:50:16 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:50:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:16 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f788ad08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2143670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d28c0>, '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 0x21d37c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d3c50>, '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': '1b9da9da7504fe468691862d000001b9-1455716216.376648-1824933311', '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 05:50:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 05:50:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:50:16 INFO - Using env: {'DISPLAY': ':0', 05:50:16 INFO - 'HOME': '/home/cltbld', 05:50:16 INFO - 'LANG': 'en_US.UTF-8', 05:50:16 INFO - 'LANGUAGE': 'en_US:en', 05:50:16 INFO - 'LOGNAME': 'cltbld', 05:50:16 INFO - 'MAIL': '/var/mail/cltbld', 05:50:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:16 INFO - 'MOZ_NO_REMOTE': '1', 05:50:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:16 INFO - 'NO_EM_RESTART': '1', 05:50:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:50:16 INFO - 'PWD': '/builds/slave/test-pgo', 05:50:16 INFO - 'SHELL': '/bin/bash', 05:50:16 INFO - 'SHLVL': '1', 05:50:16 INFO - 'TERM': 'linux', 05:50:16 INFO - 'TMOUT': '86400', 05:50:16 INFO - 'USER': 'cltbld', 05:50:16 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1455716216.376648-1824933311', 05:50:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:16 INFO - '_': '/tools/buildbot/bin/python'} 05:50:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:16 INFO - Downloading/unpacking flake8 05:50: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 05:50: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 05:50: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 05:50: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 05:50: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 05:50: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 05:50:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:50:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:50:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:50:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:50:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:50:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:50:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:50:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:50:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:50:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:50:19 INFO - no previously-included directories found matching 'docs/_build' 05:50:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:50:19 INFO - Running setup.py install for pep8 05:50:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:50:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:50:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:50:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:50:19 INFO - no previously-included directories found matching 'docs/_build' 05:50:19 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:50:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:50:19 INFO - Cleaning up... 05:50:19 INFO - Return code: 0 05:50:19 INFO - Running post-action listener: _resource_record_post_action 05:50:19 INFO - Running post-action listener: _start_resource_monitoring 05:50:19 INFO - Starting resource monitoring. 05:50:19 INFO - ##### 05:50:19 INFO - ##### Running install step. 05:50:19 INFO - ##### 05:50:19 INFO - Running pre-action listener: _resource_record_pre_action 05:50:19 INFO - Running main action method: install 05:50:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:50:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:50:19 INFO - Reading from file tmpfile_stdout 05:50:19 INFO - Detecting whether we're running mozinstall >=1.0... 05:50:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:50:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:50:19 INFO - Reading from file tmpfile_stdout 05:50:19 INFO - Output received: 05:50:19 INFO - Usage: mozinstall [options] installer 05:50:19 INFO - Options: 05:50:19 INFO - -h, --help show this help message and exit 05:50:19 INFO - -d DEST, --destination=DEST 05:50:19 INFO - Directory to install application into. [default: 05:50:19 INFO - "/builds/slave/test-pgo"] 05:50:19 INFO - --app=APP Application being installed. [default: firefox] 05:50:19 INFO - mkdir: /builds/slave/test-pgo/build/application 05:50:19 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'] 05:50:19 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 05:50:36 INFO - Reading from file tmpfile_stdout 05:50:36 INFO - Output received: 05:50:36 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:50:36 INFO - Running post-action listener: _resource_record_post_action 05:50:36 INFO - ##### 05:50:36 INFO - ##### Running run-tests step. 05:50:36 INFO - ##### 05:50:36 INFO - Running pre-action listener: _resource_record_pre_action 05:50:36 INFO - Running main action method: run_tests 05:50:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:50:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:50:36 INFO - Python 2.7.3 05:50:36 INFO - Return code: 0 05:50:36 INFO - grabbing minidump binary from tooltool 05:50:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:36 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 0x21d28c0>, '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 0x21d37c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d3c50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:50:36 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 05:50:36 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 05:50:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:50:36 INFO - Return code: 0 05:50:36 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:50:36 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:50:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:50:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:50:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:50:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:50:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:50:37 INFO - Return code: 0 05:50:37 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NJdWzCIQTmeO9x8K7jWXXQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 05:50:37 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-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NJdWzCIQTmeO9x8K7jWXXQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:50:37 INFO - Using env: {'DISPLAY': ':0', 05:50:37 INFO - 'HOME': '/home/cltbld', 05:50:37 INFO - 'LANG': 'en_US.UTF-8', 05:50:37 INFO - 'LANGUAGE': 'en_US:en', 05:50:37 INFO - 'LOGNAME': 'cltbld', 05:50:37 INFO - 'MAIL': '/var/mail/cltbld', 05:50:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:50:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:50:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:37 INFO - 'MOZ_NO_REMOTE': '1', 05:50:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:50:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:37 INFO - 'NO_EM_RESTART': '1', 05:50:37 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:50:37 INFO - 'PWD': '/builds/slave/test-pgo', 05:50:37 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:50:37 INFO - 'SHELL': '/bin/bash', 05:50:37 INFO - 'SHLVL': '1', 05:50:37 INFO - 'TERM': 'linux', 05:50:37 INFO - 'TMOUT': '86400', 05:50:37 INFO - 'USER': 'cltbld', 05:50:37 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1455716216.376648-1824933311', 05:50:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:37 INFO - '_': '/tools/buildbot/bin/python'} 05:50:37 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NJdWzCIQTmeO9x8K7jWXXQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:50:37 INFO - mozversion application_buildid: 20160217030229 05:50:37 INFO - mozversion application_changeset: 15621f98b53b1994c7ae2e2703a6e50203c5304c 05:50:37 INFO - mozversion application_display_name: Nightly 05:50:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:50:37 INFO - mozversion application_name: Firefox 05:50:37 INFO - mozversion application_remotingname: firefox 05:50:37 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:50:37 INFO - mozversion application_vendor: Mozilla 05:50:37 INFO - mozversion application_version: 47.0a1 05:50:37 INFO - mozversion platform_buildid: 20160217030229 05:50:37 INFO - mozversion platform_changeset: 15621f98b53b1994c7ae2e2703a6e50203c5304c 05:50:37 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:50:37 INFO - mozversion platform_version: 47.0a1 05:50:37 INFO - using testdate: 1455717037 05:50:37 INFO - actual date: 1455717037 05:50:37 INFO - starting webserver on 'localhost:55315' 05:50:37 INFO - SUITE-START | Running 2 tests 05:50:37 INFO - TEST-START | dromaeo_css 05:50:37 INFO - operating with platform_type : linux_ 05:50:37 INFO - Initialising browser for dromaeo_css test... 05:50:37 INFO - TEST-INFO | started process 26530 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFB1nO_/profile http://localhost:55315/getInfo.html) 05:50:41 INFO - PROCESS | 26530 | 05:50:41 INFO - PROCESS | 26530 | (process:26610): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:50:41 INFO - PROCESS | 26530 | __metrics Screen width/height:1600/1200 05:50:41 INFO - PROCESS | 26530 | colorDepth:24 05:50:41 INFO - PROCESS | 26530 | Browser inner width/height: 1024/697 05:50:41 INFO - PROCESS | 26530 | __metrics 05:50:43 INFO - TEST-INFO | 26530: exit 0 05:50:43 INFO - Browser initialized. 05:50:43 INFO - Running cycle 1/1 for dromaeo_css test... 05:50:43 INFO - TEST-INFO | started process 26661 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFB1nO_/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:50:44 INFO - PROCESS | 26661 | 05:50:44 INFO - PROCESS | 26661 | (process:26720): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:50:55 INFO - PROCESS | 26661 | RSS: Main: 156991488 05:50:55 INFO - PROCESS | 26661 | 05:51:44 INFO - PROCESS | 26661 | 1455717104675 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] 05:53:53 INFO - PROCESS | 26661 | Cycle 1(1): loaded http://localhost:55315/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55315/tests/dromaeo/cssquery-ext.html) 05:53:54 INFO - PROCESS | 26661 | RSS: Main: 166473728 05:53:54 INFO - PROCESS | 26661 | 05:56:56 INFO - PROCESS | 26661 | Cycle 1(1): loaded http://localhost:55315/tests/dromaeo/cssquery-ext.html (next: http://localhost:55315/tests/dromaeo/cssquery-jquery.html) 05:56:56 INFO - PROCESS | 26661 | RSS: Main: 160133120 05:56:56 INFO - PROCESS | 26661 | 05:59:58 INFO - PROCESS | 26661 | Cycle 1(1): loaded http://localhost:55315/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55315/tests/dromaeo/cssquery-mootools.html) 05:59:59 INFO - PROCESS | 26661 | RSS: Main: 162009088 05:59:59 INFO - PROCESS | 26661 | 06:03:01 INFO - PROCESS | 26661 | Cycle 1(1): loaded http://localhost:55315/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55315/tests/dromaeo/cssquery-prototype.html) 06:03:01 INFO - PROCESS | 26661 | RSS: Main: 159551488 06:03:01 INFO - PROCESS | 26661 | 06:06:03 INFO - PROCESS | 26661 | Cycle 1(1): loaded http://localhost:55315/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55315/tests/dromaeo/cssquery-yui.html) 06:06:04 INFO - PROCESS | 26661 | RSS: Main: 159703040 06:06:04 INFO - PROCESS | 26661 | 06:09:06 INFO - PROCESS | 26661 | Cycle 1(1): loaded http://localhost:55315/tests/dromaeo/cssquery-yui.html (next: http://localhost:55315/tests/dromaeo/cssquery-dojo.html) 06:09:07 INFO - PROCESS | 26661 | RSS: Main: 163917824 06:09:07 INFO - PROCESS | 26661 | 06:09:07 INFO - PROCESS | 26661 | __start_tp_report 06:09:07 INFO - PROCESS | 26661 | _x_x_mozilla_page_load 06:09:07 INFO - PROCESS | 26661 | _x_x_mozilla_page_load_details 06:09:07 INFO - PROCESS | 26661 | |i|pagename|runs| 06:09:07 INFO - PROCESS | 26661 | |0;dojo.html;3138.748900087993;3150.6376766671833;3163.8734450621946;3192.872285108596;3200.2799370141715;5096.770645320956;5122.359705036871;5124.820631277897;5189.273501709759;5212.2963399941;5173;5258.027264955986;5303.628745987782;5304.840854774353;5308.867278318044;4807.711537307755;4860.902781944359;4866.902661946759;4962.677425967318;4966.329545511364;4765.0946320199055;4955.801767929296;4992.700437973715;4998.675086119409;5041.243813427996;4662.254039353704;4733.739644319561;4769.356136921506;4774.4509381420885;4775.2598347256235;4821.156297647933;4827.444843842968;4849.490803465621;4854.344663470457;4862.95137048632;4766.451858036336;4781.426228852525;4839.153148199051;4857;4879.292502587141;5014.724190169539;5062.417821950449;5089.1094058539975;5102.285680004802;5136.280920671109;5569.331680198362;5617.297837770278;5618.185363122365;5627.296587926509;5670.3479099903625;5506.669599824023;5589.105743081128;5591.860203494904;5596.972015139939;5604.3835178130375;5352.866178345534;5353.0899747043095;5373.113436283009;5380.704061276589;5383.75773090208;5874.73563689635;5919.378465261172;5924.822255332347;5928.703564821742;5938.732757025944;5652.886942261214;5681.602287839812;5702.429757024264;5711.200431939532;5713.171590119493;5674.26234589509;5764.337101233412;5766.711664416763;5767.942320576741;5771.105478650816;5533.391326954032;5538.113901775697;5588.692621905834;5589.74846131925;5623.8875222496135;5620.100783874561;5648.293963254593;5689.061304884731;5694.174344719992;5724.885502289931;4341.6526677865695;4389.62688171509;4431.180231657154;4441.888952776207;4470.8435204767675;3905.72659913809;3919.098607320332;3926.489556357655;3940.822662980173;3964.702647301464;5346.812861549827;5363.490468405495;5365;5370.194470829407;5391.541718953855;5582.939241544093;5656;5671.546276297886;5684.54523638108;5759.510441612426;5425.403205647375;5425.620206585501;5444.40111587725;5458.61789674719;5459.672419654833;4907.779149938261;4909.705417674951;4921.188003979375;4932.901341973212;4966.751662416937;5661.490465858093;5914.8817023659285;5948.67282299469;5981.342052374235;6019.879602408015;5707.514861236841;5707.942920570741;5736.4550367715;5762.855928601651;5765.5675824314185;5823.854403639943;5853.9121913172185;5957.970210148921;5972.044472884318;5977.790777322773;5572.972135139298;5583.162525621189;5583.8883222336135;5594.664320140804;5616.69108199053;5685;5685.34618518859;5721.828345149652;5737.540996720336;5741.110127930177;5455.754491047833;5484.917726234189;5515.310586176728;5617.634853734494;5657.886842263214;5485.122380419114;5491.478309560585;5512.889742205213;5536.363318218457;5540.722963851872;5439.9456005441025;5442.510174084351;5449.618526703092;5453.263809385682;5496.120620700829;5384.165454354425;5548.223248745098;5645.266115404971;5669.234653321749;5712.914306285492;5375.435579264277;5405.864853378697;5446.291982042309;5455.208994695826;5463.125899856004 06:09:07 INFO - PROCESS | 26661 | |1;ext.html;520.3807469111758;537.9085555455574;550.2846299810245;566.2384093394384;567.3645517020938;34850.82574587127;35022.82488587553;35509.82245088771;35649.108772280706;35741.28517429653;36865.63134368655;37543.43684844723;37563;37585.812070939675;37622.24755504888;8395.664173433055;8566.528840913747;8572.914270857274;8574.657013719443;8620.698275560357;8574.35692323075;8727;8748.518831464267;8767.473951562895;8798.164174403422;8755.518446485441;8795.912040879606;8833;8842.823143537158;8858.069902660225;8705.129487051276;8727.301815854747;8754.56227188638;8785;8786.912130878673;8708.78228044304;8849.292056635453;8863.822723545558;8867;8867.73396798097;37533.436998445046;37552.24895502102;37775.43336849949;37846.43230351547;37862.24275514474;3200.695933886277;3777.338965680995;3952.980235098835;4014.6788256939376;4128.504579450455;29290.41419171626;29885.70114298851;30050.24874378158;30460.54309185342;30465;3977.184677141208;4007.6793856491413;4011.2579172852825;4073.6944729145434;4125.834966601333;268919;269730;271010.999999998;271512;271997;53093.73453132787;58207.70896145492;58735;58908.410915890294;59170.70414647985;52543.73728131335;52708.73645631824;52914.206286905726;53183;53229.73385133049;15944.521664350088;15951.644110250758;16151;16189.19054047293;16250.75623865643;11708.648740537797;11743.588974385855;11799.115066370057;11928.880711192951;11984.101192410604;19236.326728564432;20337.288194913108;20532.07605657749;20580;20708;7470.252974702486;7592.924070759222;7615.428842836809;7673;7768.572728499874;850.5832142250376;932.3333816321227;936.1714882329188;997.2620261006803;998.1864780204111;27956.86021569879;28284.292892677848;28744.568831467546;29003.12990610285;29399.85300073486;1030.4229631406436;1064.1486810551528;1091.2034215022918;1148.586508856811;1150.1316506037888;15448.613784655474;15582.688346233012;15597.68804623901;15875.444359447594;16100.597485062966;386077;392257;393619;393687;394845;55592.72203638956;56332.718336408056;56512.43487565154;56639;56857.431425685216;1315.2963164707028;1322.1868550841164;1335.3123141582093;1358.9048766586245;1362.1826903857805;29687.85156074206;30582.541261880644;30906.845465773426;30912.536311955788;31346.843265783526;47310.52689473061;48067.27899081447;48080.5191948076;48171.5182848167;48314;280796;282052;282479;283925;284545;30550.84724576452;44214.778926105166;44645.77677111594;44810.327845081694;45969.77015115037;39888.2022359557;39959;40448.1910361797;40650.39024414577;40687;34295.485567717005;34413.65586344204;34904.65095349014;34980.30039399147;38477.422838658;37041.51833926613;37229.62770372262;37554.24891502209;37717.2456550862;37946.24107517889;34943.475847862814;35148.472772908935;35240.47139292964;35543.11142221465;35897.28205435929;31318.68681313158;31526;33699.494507582895;33857;33955.4906676405;25234.855037322035;25689.743102568737;25823.354416139748;26005;26031.869840650674 06:09:07 INFO - PROCESS | 26661 | |2;jquery.html;363.3931334671099;367.89514988228353;369.59529315399635;369.6082152917907;369.8520591763296;11558.711032224199;12064.939675301634;15996.68006639868;16293;16723.91638041811;17203.311867525314;17327;17551.736723949118;17599.472015839547;17605.82394176058;5945.732442040118;6213.161223234873;6257.124002639634;6263.248410190783;6270.278917924428;5985.461308482236;6111.908321375183;6125.754969801203;6162.476189523896;6197.5351848611535;4467.41923549938;6149.631022138686;6161.907571386433;6728.250654829731;6967.163940327143;6770.69531871067;6913.343232392915;6926.58440493572;6929.861402771941;7107.6090815005155;6685.866282674319;6752.257251702309;6761.560498567626;6798.150231221098;6798.626075565842;22205.22281720132;22893.542129157322;23108.0756769729;23202.883985580134;23208.187713430118;2208.514126892081;2271.965920511194;2306.6078766609717;2417.0452671194957;2714.4571085782727;9733.610655573768;13671.589852304447;14572.70854582913;14644.41422343105;14734.557963261119;2019.8788072715683;2034.8575599708026;2070.4306315763133;2100.2019232691478;2119.0782009825775;70029;72281.63859180723;72388.63805680991;73066;73285.6335718318;15309.157996310087;15636.374545018072;15809;15841.762373564407;15933.442329518411;24008.27975160748;24105.156319529084;24632;24650.876745616515;24776.504469910862;6986.54587451814;7258.056452661121;7631.732889348847;7688.38492920565;7715.421343399267;7360.852782944311;7362.411007119417;7376.557406555624;7411.110666720028;7436.40508759298;4517.457905051415;4594.379758732595;4608.331791890158;4612.930806037912;4618;1814.4284550366592;1853.3605905962422;1868.588910439701;1880.7555017847867;1911.149538455374;867.4058270085012;953.3707752883203;965.0494263150791;1000.6347683095618;1048.7849990751877;16261.837381626032;17306.567335816453;17394.826051739572;17935.910320448314;18059.2776288947;448.5357654827303;455.4602795687121;465.1534207741945;470.6399604302711;470.8846332648523;6041.758329666852;6105.481034112061;6250.9062364064575;6272;6336.746530138743;525074;526784.8303792436;526819;557381;595426;76782;78670;79990;80579.59710201412;80796.59601702071;533.6291277562135;535.7669413804929;537.946205379451;543.3751186135976;544.0479161467432;10335.689929302132;10696.51618141385;10784.676459706221;10833.729156771144;10868.78262434731;33720.32559348848;34650;34901.8254908734;34958.475622866186;35281.47077793784;44764;45215;49214.26178607252;49359.75320123376;49488.75255623699;7950.562719050507;8209.466384684976;8259.669613215645;8306.70926517569;8338.583070846313;11324.547018119512;12385.19496232742;12693.492260309853;12725.872741272839;12960.611181664564;9806.509674516103;9811.362261452983;9868;10246.897531024595;10514.421706806199;10373.844392333971;10625.787484250117;10666.146708263475;10692.518836652525;10906.400147991619;10769.461526923778;10945.129994574265;11122.332660040423;11288.2662626929;11396.259243149168;7430.777076687708;8168.8366232673825;8301.169883011651;8334.12491688364;8340.541270230196;10140;10234.437105959243;10425.113865321533;10482.213833962636;10541.841872372073 06:09:07 INFO - PROCESS | 26661 | |3;mootools.html;1476.3135142158894;1489.3744627256553;1645.6215070533776;1767.6376342849717;1769.4603146040452;6800.081988931493;7371.926280737191;7496.81257968551;7540.245975402464;7598.810029749252;7370.447216458773;7468.066491688539;7506.96246518768;7510.1738808731;7512.66193021314;2203.3389983005072;2228.7771222877745;2230.620794464937;2237.407087121914;2240.4622890506325;2212.8451008429415;2218.001899145383;2277.840551161419;2280.247518318951;2281.178775640768;1951.541387773872;2193;2217.73387193537;2225.2434172381386;2230.308604332662;2184.060853832851;2236.865788052722;2263.196565219348;2267.580497607931;2268.8638681679154;2223.5108276179217;2236.105557776902;2237.093976939342;2240.19353032908;2243.3270018994235;7346.96326518364;7374.852502949964;7396.3713084387355;7400.555966642019;7416.369608583277;4636.629069674418;4760.857174284777;4765.142274390609;4792.113459010095;4795.6403269754555;3053.7404320632772;3110;3187.15540381799;3213.2127628730877;3237.190702324419;946.3895787217207;952.2667545989618;983.311681822727;984.5421878826309;1028.2596530498029;10251.436171010591;10280.177585793193;10309.226807989357;10319.690409287658;10380.688579342632;4257.914841703148;4301.419308393327;4332.566743325642;4358.302671572533;4366.257736184856;8804.647814087493;8831.735047948572;8848.1151884811;8868.955655221682;8885.511296878605;4803.1114243864995;4815.831445899376;4823.03539292143;4831.685940413862;4854.902901941941;4356.823657612427;4379.890502737457;4387.583179597933;4409.933850992237;4412.646988240933;3520.9471857922154;3560.359135355609;3561.1631266652316;3563.8773786257248;3601.3517566838223;1154.0825044089968;1167.9299242045504;1172.0857730969858;1178.5462596900084;1180.114913814639;891.1934699097327;1007.3200589601989;1036.8392899100652;1102.3165637304921;1317.2623330934707;6985.720571177198;7041.436685065182;7068.974998625171;7076.080109585824;7078.292170782881;1095.3482677806692;1095.9890401095886;1100.3287994323457;1123.764009558002;1138.743782648914;5571.498565129077;5619.297587801525;5660.462256085665;5684.459976302244;5700.629459085229;8836.072212417603;9188;9239.538023098818;9249.90750092504;9254.814903701888;9051.411658242194;9126.771830704152;9127.041660625538;9214.308926830514;9234.122758337948;6910.585364878123;6934.271901450275;7052.753153639701;7082.858342833218;7083.079199704005;7180.640967951686;7279.854402911807;7300;7324.670389832577;7337.963310183629;7837.373010159287;8164.550949697824;8301.875471867806;8304.709335173482;8368.7907802303;8240.258376746122;8341.374396920133;8361.665533378597;8432.114627963976;8447.366447516584;6598.571092878948;6827.931720682928;6851.109355783916;6852.794416167323;6877.58734475933;7337.229590892879;7343;7396.445266604918;7404.962975185305;7409.629518523944;6111.54163437735;6929.7228110875;7023.683934223074;7047.859042819217;7233.529820561646;6916.896246556406;6955.23492415844;6964.512484126062;7038.753643622448;7085.929140708527;6888.793336199922;7066.328698773608;7074.646267686698;7086.078809754699;7091.893621595577;6509.934900650933;6583.275839657729;6584.242812076481;6586.769463068769;6597.109390232449;5957.374475680164;5982.551308651781;5983.563944653339;5988.251468566429;6150.876982460415 06:09:07 INFO - PROCESS | 26661 | |4;prototype.html;343.56195850290874;344.5193954433567;346.668931170732;347.4822514453464;348.82733047141653;6095.3599872013465;6198.5041196704215;6209.503239740821;6271.122042913984;6304.275008374038;6242.937570624293;6249.531285153609;6262.780802671896;6266.84332891678;6271.498280137589;4767.594754445876;4780.8565743027675;4790.161721698706;4794.400699912511;4803.3995750531185;4793.328933949232;4799.952000479985;4803.63972702047;4814.1334559779225;4815.66290359675;4678.485366609671;4803.231482962727;4804.87987800306;4808.374911261531;4814.0371925614845;4806.086843499724;4808.302796094564;4813.711177329354;4825.20384136617;4826.131296366652;4231.809568569422;4236.830526778926;4242.66058715302;4249.447571815645;4254.212970600449;5926.851828704317;5930.169776231331;5931.673757943311;5933.3473317934995;5944.138099975523;5519.089350257203;5638.126090455986;5641.774329026834;5650;5657.12314591239;6633.872241718919;6645.501587380966;6657.633830139341;6659.733610655568;6660.666966651696;4670.136024835382;4680.812767489297;4686;4693.460252070987;4701.294805779126;6713.731450741964;6964.616946068015;6965.407940325078;6980.092587963532;7004.47466440014;4621.976890115528;4636.35091087248;4639.86080417588;4644.465886423037;4646.372739680168;4692.343071969927;4696.483386827446;4698.788554515055;4699.224627936421;4704.976475117603;5470.91793623096;5476.315460567429;5479.671219726829;5484.985277723634;5488.69812160327;6538.411542961157;6671.933280667228;6688.7324507019175;6698.531102822755;6699.933000669931;1610.1627153879917;1644.7121753693295;1646.8929519581188;1651.1331550935615;1652.396875140565;1096.2107282756403;1097.0839349143396;1112.9721756955978;1116.6538373104363;1121.377635412354;6133.539984501181;6229.501639868799;6233.252009758858;6267.122602835607;6277.435030847246;6760.898586521206;6771.223798242697;6794.320567943265;6799.150106236721;6800.183977922582;6142.969285153546;6222.533310001768;6241.375862413813;6248.781292654735;6251;3662.102784817737;3666.395044817629;3680.8159592020293;3680.9079773005355;3686.4286035664513;7128.714851405885;7149;7151.427885769126;7158.498905076699;7160.033395491646;6754.729810807513;6970.372666460043;6975.965120174366;6995.300469953066;7001.544899581511;7100.396466300319;7106.5736055836815;7109.502334836512;7112.679929403189;7125.714971401189;6742.123523941857;6747.460203183636;6749.493787965824;6761.357671021246;6797.388235058868;6517.608943463218;6611.305812889577;6637.402633762791;6639.834004149935;6652.767153149616;6919.20429150634;6925.238223795278;6941.062956500808;6950;6962.3037696231995;4615.515370886143;4655.813767449399;4662.976685116552;4664.300354946649;4668.626509879269;6619.867602648016;6768.492363072691;6779.830504237236;6788.558743681645;6816.2842901496615;6709.865802683821;6716.059751634677;6731.057651928832;6739.359760822714;6749.5612785168805;6693.933060669331;6701.932980670131;6711.530192886451;6721.663916804238;6730.32696730323;6450;6572.211334639874;6594.10979517759;6653.600783952978;6681.465482761465;6743.089682892747;6759.493038022267;6765.154355705537;6766.289539598468;6778.694958726967;6555.049517819794;6576.375244351779;6576.8355791105605;6602.7689030883685;6607.306232845482 06:09:07 INFO - PROCESS | 26661 | |5;yui.html;638.3488841381794;642.8939225027867;758.3175142371863;768.4851149729681;794.3089512124451;13806.930965345171;13948.372323245465;14068.718625627482;14138.293085345716;14153.646158846033;13329.866701332983;13349.733005339887;13369.465221391132;13381.59855204343;13405.731885362287;659.0904551718634;806.4717609965483;806.4757907360204;806.8830019647177;808.5472135604051;790.1979490816825;791.8455901099288;792.1009654042674;794.8410317936407;795.2643804480832;824.2952275804191;825.3149885594971;830.6303694855792;832.4921797703396;833.1834801894147;827.1067247372853;827.4786884262905;829.4111181061423;832.6627715775121;834.6661335465801;603.5594016368032;604.2115039872964;604.8699529601113;605.4974371271834;605.5397897597813;13805.654858628615;13843.653908652264;13862.792058119136;13933.164010159422;13941.651458713613;12845.935770321183;13269.270190139538;13643.02984660505;13687.931560342235;13743.381547830371;10462.790744185073;10597.470126493645;10803.13574914005;10877.891221087766;11205.551777928873;3642.8724994625327;3695.575008873987;3739.383001804699;3750.1749615084636;3803.0112170835782;47387.52612473866;47798.52201477975;48185.277220841715;48274.27588586174;48545.27182092236;9123.315751318678;9375.390599611004;9648.75878103053;9770.560324785401;9876.40741555509;18697.15862786178;18881.339153129575;18882.24471021144;18885.716714249298;18971.956542390024;7554.584497852561;7790.727324543614;7839.804004899809;7920.6039698014865;8130.471519351223;4338.262495375794;4437.866863994085;4449.176902273025;4450.977745111254;4465.910681786411;3109.284864481182;3135;3138.6076740407448;3146.3392687535415;3149.5590617313596;532.052945756554;562.3420597900466;563.0596903171713;574.1129954220739;584.5031723035386;578.531389574446;662.2582212220063;698.7100353353302;703.2229386527813;741.5143081281769;8424.663013479514;8681.088485709037;8710;8752.91247087521;8764.123587641185;515.1885779896678;540.6620861961275;672.9697163627649;682.4165338635395;696.7108649910332;3901.2496190185852;4056.371262454324;4151.501819781645;4245.936310955338;4262.381954616563;52722.20916686253;54033.72983135059;54755.726221369434;54860.451395486336;54885.451145488834;49886.25170622444;50559;50868.23697644538;53937.1909421359;55065.1740223897;44678;45463.54536454659;45721.7713911435;46504.3024354635;46767.999999999316;8727.65089396417;8729.607167677343;8980.550972451481;9010.549472526216;9033.683821066232;33626.32747344991;34730;34999.475007875415;35461.46807797936;35914.820425898746;39392.2121557573;39937.40093898652;41678.79160604178;42544.57455425406;42945.35581966335;10798.622048228275;11131.220814542905;11204.215704900578;11253.381064041228;11416.31502109876;11814.468348924147;11854.822177667515;11881.287122772315;11984.46069926838;12322.260664360167;10370.740731481774;10505.369677819355;10513.632022879163;10879.456027198767;10980.725481863017;10948.288361256493;11091.611793587508;11112.333260004425;11417.828732568853;11597.07223422141;10535.367877927349;10888.727781805519;11078.778424431304;11273.549058037586;11284;9091.499967501852;9123.489096573208;9324.487153206639;9801.460919649488;10168.237382196512;8725.781855453664;8814.91185088141;9009.549522523717;9558.378705384128;9585.137337639646 06:09:07 INFO - PROCESS | 26661 | __end_tp_report 06:09:07 INFO - PROCESS | 26661 | __start_cc_report 06:09:07 INFO - PROCESS | 26661 | _x_x_mozilla_cycle_collect,313 06:09:07 INFO - PROCESS | 26661 | __end_cc_report 06:09:07 INFO - PROCESS | 26661 | __startTimestamp1455718147148__endTimestamp 06:09:07 INFO - PROCESS | 26661 | 06:09:07 INFO - PROCESS | 26661 | ------- Summary: start ------- 06:09:07 INFO - PROCESS | 26661 | Number of tests: 6 06:09:07 INFO - PROCESS | 26661 | 06:09:07 INFO - PROCESS | 26661 | [#0] dojo.html Cycles:165 Average:5280.42 Median:5455.75 stddev:585.23 (10.7%) stddev-sans-first:562.39 06:09:07 INFO - PROCESS | 26661 | Values: 3138.7 3150.6 3163.9 3192.9 3200.3 5096.8 5122.4 5124.8 5189.3 5212.3 5173.0 5258.0 5303.6 5304.8 5308.9 4807.7 4860.9 4866.9 4962.7 4966.3 4765.1 4955.8 4992.7 4998.7 5041.2 4662.3 4733.7 4769.4 4774.5 4775.3 4821.2 4827.4 4849.5 4854.3 4863.0 4766.5 4781.4 4839.2 4857.0 4879.3 5014.7 5062.4 5089.1 5102.3 5136.3 5569.3 5617.3 5618.2 5627.3 5670.3 5506.7 5589.1 5591.9 5597.0 5604.4 5352.9 5353.1 5373.1 5380.7 5383.8 5874.7 5919.4 5924.8 5928.7 5938.7 5652.9 5681.6 5702.4 5711.2 5713.2 5674.3 5764.3 5766.7 5767.9 5771.1 5533.4 5538.1 5588.7 5589.7 5623.9 5620.1 5648.3 5689.1 5694.2 5724.9 4341.7 4389.6 4431.2 4441.9 4470.8 3905.7 3919.1 3926.5 3940.8 3964.7 5346.8 5363.5 5365.0 5370.2 5391.5 5582.9 5656.0 5671.5 5684.5 5759.5 5425.4 5425.6 5444.4 5458.6 5459.7 4907.8 4909.7 4921.2 4932.9 4966.8 5661.5 5914.9 5948.7 5981.3 6019.9 5707.5 5707.9 5736.5 5762.9 5765.6 5823.9 5853.9 5958.0 5972.0 5977.8 5573.0 5583.2 5583.9 5594.7 5616.7 5685.0 5685.3 5721.8 5737.5 5741.1 5455.8 5484.9 5515.3 5617.6 5657.9 5485.1 5491.5 5512.9 5536.4 5540.7 5439.9 5442.5 5449.6 5453.3 5496.1 5384.2 5548.2 5645.3 5669.2 5712.9 5375.4 5405.9 5446.3 5455.2 5463.1 06:09:07 INFO - PROCESS | 26661 | 06:09:07 INFO - PROCESS | 26661 | [#1] ext.html Cycles:180 Average:48238.03 Median:37669.75 stddev:83923.81 (222.8%) stddev-sans-first:84082.77 06:09:07 INFO - PROCESS | 26661 | Values: 520.4 537.9 550.3 566.2 567.4 34850.8 35022.8 35509.8 35649.1 35741.3 36865.6 37543.4 37563.0 37585.8 37622.2 8395.7 8566.5 8572.9 8574.7 8620.7 8574.4 8727.0 8748.5 8767.5 8798.2 8755.5 8795.9 8833.0 8842.8 8858.1 8705.1 8727.3 8754.6 8785.0 8786.9 8708.8 8849.3 8863.8 8867.0 8867.7 37533.4 37552.2 37775.4 37846.4 37862.2 3200.7 3777.3 3953.0 4014.7 4128.5 29290.4 29885.7 30050.2 30460.5 30465.0 3977.2 4007.7 4011.3 4073.7 4125.8 268919.0 269730.0 271011.0 271512.0 271997.0 53093.7 58207.7 58735.0 58908.4 59170.7 52543.7 52708.7 52914.2 53183.0 53229.7 15944.5 15951.6 16151.0 16189.2 16250.8 11708.6 11743.6 11799.1 11928.9 11984.1 19236.3 20337.3 20532.1 20580.0 20708.0 7470.3 7592.9 7615.4 7673.0 7768.6 850.6 932.3 936.2 997.3 998.2 27956.9 28284.3 28744.6 29003.1 29399.9 1030.4 1064.1 1091.2 1148.6 1150.1 15448.6 15582.7 15597.7 15875.4 16100.6 386077.0 392257.0 393619.0 393687.0 394845.0 55592.7 56332.7 56512.4 56639.0 56857.4 1315.3 1322.2 1335.3 1358.9 1362.2 29687.9 30582.5 30906.8 30912.5 31346.8 47310.5 48067.3 48080.5 48171.5 48314.0 280796.0 282052.0 282479.0 283925.0 284545.0 30550.8 44214.8 44645.8 44810.3 45969.8 39888.2 39959.0 40448.2 40650.4 40687.0 34295.5 34413.7 34904.7 34980.3 38477.4 37041.5 37229.6 37554.2 37717.2 37946.2 34943.5 35148.5 35240.5 35543.1 35897.3 31318.7 31526.0 33699.5 33857.0 33955.5 25234.9 25689.7 25823.4 26005.0 26031.9 06:09:07 INFO - PROCESS | 26661 | 06:09:07 INFO - PROCESS | 26661 | [#2] jquery.html Cycles:180 Average:29280.47 Median:2483.00 stddev:89526.39 (3605.6%) stddev-sans-first:89751.20 06:09:07 INFO - PROCESS | 26661 | Values: 363.4 367.9 369.6 369.6 369.9 11558.7 12064.9 15996.7 16293.0 16723.9 17203.3 17327.0 17551.7 17599.5 17605.8 5945.7 6213.2 6257.1 6263.2 6270.3 5985.5 6111.9 6125.8 6162.5 6197.5 4467.4 6149.6 6161.9 6728.3 6967.2 6770.7 6913.3 6926.6 6929.9 7107.6 6685.9 6752.3 6761.6 6798.2 6798.6 22205.2 22893.5 23108.1 23202.9 23208.2 2208.5 2272.0 2306.6 2417.0 2714.5 9733.6 13671.6 14572.7 14644.4 14734.6 2019.9 2034.9 2070.4 2100.2 2119.1 70029.0 72281.6 72388.6 73066.0 73285.6 15309.2 15636.4 15809.0 15841.8 15933.4 24008.3 24105.2 24632.0 24650.9 24776.5 6986.5 7258.1 7631.7 7688.4 7715.4 7360.9 7362.4 7376.6 7411.1 7436.4 4517.5 4594.4 4608.3 4612.9 4618.0 1814.4 1853.4 1868.6 1880.8 1911.1 867.4 953.4 965.0 1000.6 1048.8 16261.8 17306.6 17394.8 17935.9 18059.3 448.5 455.5 465.2 470.6 470.9 6041.8 6105.5 6250.9 6272.0 6336.7 525074.0 526784.8 526819.0 557381.0 595426.0 76782.0 78670.0 79990.0 80579.6 80796.6 533.6 535.8 537.9 543.4 544.0 10335.7 10696.5 10784.7 10833.7 10868.8 33720.3 34650.0 34901.8 34958.5 35281.5 44764.0 45215.0 49214.3 49359.8 49488.8 7950.6 8209.5 8259.7 8306.7 8338.6 11324.5 12385.2 12693.5 12725.9 12960.6 9806.5 9811.4 9868.0 10246.9 10514.4 10373.8 10625.8 10666.1 10692.5 10906.4 10769.5 10945.1 11122.3 11288.3 11396.3 7430.8 8168.8 8301.2 8334.1 8340.5 10140.0 10234.4 10425.1 10482.2 10541.8 06:09:07 INFO - PROCESS | 26661 | 06:09:07 INFO - PROCESS | 26661 | [#3] mootools.html Cycles:180 Average:5361.17 Median:6330.41 stddev:2734.37 (43.2%) stddev-sans-first:2726.45 06:09:07 INFO - PROCESS | 26661 | Values: 1476.3 1489.4 1645.6 1767.6 1769.5 6800.1 7371.9 7496.8 7540.2 7598.8 7370.4 7468.1 7507.0 7510.2 7512.7 2203.3 2228.8 2230.6 2237.4 2240.5 2212.8 2218.0 2277.8 2280.2 2281.2 1951.5 2193.0 2217.7 2225.2 2230.3 2184.1 2236.9 2263.2 2267.6 2268.9 2223.5 2236.1 2237.1 2240.2 2243.3 7347.0 7374.9 7396.4 7400.6 7416.4 4636.6 4760.9 4765.1 4792.1 4795.6 3053.7 3110.0 3187.2 3213.2 3237.2 946.4 952.3 983.3 984.5 1028.3 10251.4 10280.2 10309.2 10319.7 10380.7 4257.9 4301.4 4332.6 4358.3 4366.3 8804.6 8831.7 8848.1 8869.0 8885.5 4803.1 4815.8 4823.0 4831.7 4854.9 4356.8 4379.9 4387.6 4409.9 4412.6 3520.9 3560.4 3561.2 3563.9 3601.4 1154.1 1167.9 1172.1 1178.5 1180.1 891.2 1007.3 1036.8 1102.3 1317.3 6985.7 7041.4 7069.0 7076.1 7078.3 1095.3 1096.0 1100.3 1123.8 1138.7 5571.5 5619.3 5660.5 5684.5 5700.6 8836.1 9188.0 9239.5 9249.9 9254.8 9051.4 9126.8 9127.0 9214.3 9234.1 6910.6 6934.3 7052.8 7082.9 7083.1 7180.6 7279.9 7300.0 7324.7 7338.0 7837.4 8164.6 8301.9 8304.7 8368.8 8240.3 8341.4 8361.7 8432.1 8447.4 6598.6 6827.9 6851.1 6852.8 6877.6 7337.2 7343.0 7396.4 7405.0 7409.6 6111.5 6929.7 7023.7 7047.9 7233.5 6916.9 6955.2 6964.5 7038.8 7085.9 6888.8 7066.3 7074.6 7086.1 7091.9 6509.9 6583.3 6584.2 6586.8 6597.1 5957.4 5982.6 5983.6 5988.3 6150.9 06:09:07 INFO - PROCESS | 26661 | 06:09:07 INFO - PROCESS | 26661 | [#4] prototype.html Cycles:180 Average:5541.78 Median:6249.16 stddev:1670.20 (26.7%) stddev-sans-first:1628.68 06:09:07 INFO - PROCESS | 26661 | Values: 343.6 344.5 346.7 347.5 348.8 6095.4 6198.5 6209.5 6271.1 6304.3 6242.9 6249.5 6262.8 6266.8 6271.5 4767.6 4780.9 4790.2 4794.4 4803.4 4793.3 4800.0 4803.6 4814.1 4815.7 4678.5 4803.2 4804.9 4808.4 4814.0 4806.1 4808.3 4813.7 4825.2 4826.1 4231.8 4236.8 4242.7 4249.4 4254.2 5926.9 5930.2 5931.7 5933.3 5944.1 5519.1 5638.1 5641.8 5650.0 5657.1 6633.9 6645.5 6657.6 6659.7 6660.7 4670.1 4680.8 4686.0 4693.5 4701.3 6713.7 6964.6 6965.4 6980.1 7004.5 4622.0 4636.4 4639.9 4644.5 4646.4 4692.3 4696.5 4698.8 4699.2 4705.0 5470.9 5476.3 5479.7 5485.0 5488.7 6538.4 6671.9 6688.7 6698.5 6699.9 1610.2 1644.7 1646.9 1651.1 1652.4 1096.2 1097.1 1113.0 1116.7 1121.4 6133.5 6229.5 6233.3 6267.1 6277.4 6760.9 6771.2 6794.3 6799.2 6800.2 6143.0 6222.5 6241.4 6248.8 6251.0 3662.1 3666.4 3680.8 3680.9 3686.4 7128.7 7149.0 7151.4 7158.5 7160.0 6754.7 6970.4 6976.0 6995.3 7001.5 7100.4 7106.6 7109.5 7112.7 7125.7 6742.1 6747.5 6749.5 6761.4 6797.4 6517.6 6611.3 6637.4 6639.8 6652.8 6919.2 6925.2 6941.1 6950.0 6962.3 4615.5 4655.8 4663.0 4664.3 4668.6 6619.9 6768.5 6779.8 6788.6 6816.3 6709.9 6716.1 6731.1 6739.4 6749.6 6693.9 6701.9 6711.5 6721.7 6730.3 6450.0 6572.2 6594.1 6653.6 6681.5 6743.1 6759.5 6765.2 6766.3 6778.7 6555.0 6576.4 6576.8 6602.8 6607.3 06:09:07 INFO - PROCESS | 26661 | 06:09:07 INFO - PROCESS | 26661 | [#5] yui.html Cycles:180 Average:13673.69 Median:47077.76 stddev:15555.12 (33.0%) stddev-sans-first:15567.96 06:09:07 INFO - PROCESS | 26661 | Values: 638.3 642.9 758.3 768.5 794.3 13806.9 13948.4 14068.7 14138.3 14153.6 13329.9 13349.7 13369.5 13381.6 13405.7 659.1 806.5 806.5 806.9 808.5 790.2 791.8 792.1 794.8 795.3 824.3 825.3 830.6 832.5 833.2 827.1 827.5 829.4 832.7 834.7 603.6 604.2 604.9 605.5 605.5 13805.7 13843.7 13862.8 13933.2 13941.7 12845.9 13269.3 13643.0 13687.9 13743.4 10462.8 10597.5 10803.1 10877.9 11205.6 3642.9 3695.6 3739.4 3750.2 3803.0 47387.5 47798.5 48185.3 48274.3 48545.3 9123.3 9375.4 9648.8 9770.6 9876.4 18697.2 18881.3 18882.2 18885.7 18972.0 7554.6 7790.7 7839.8 7920.6 8130.5 4338.3 4437.9 4449.2 4451.0 4465.9 3109.3 3135.0 3138.6 3146.3 3149.6 532.1 562.3 563.1 574.1 584.5 578.5 662.3 698.7 703.2 741.5 8424.7 8681.1 8710.0 8752.9 8764.1 515.2 540.7 673.0 682.4 696.7 3901.2 4056.4 4151.5 4245.9 4262.4 52722.2 54033.7 54755.7 54860.5 54885.5 49886.3 50559.0 50868.2 53937.2 55065.2 44678.0 45463.5 45721.8 46504.3 46768.0 8727.7 8729.6 8980.6 9010.5 9033.7 33626.3 34730.0 34999.5 35461.5 35914.8 39392.2 39937.4 41678.8 42544.6 42945.4 10798.6 11131.2 11204.2 11253.4 11416.3 11814.5 11854.8 11881.3 11984.5 12322.3 10370.7 10505.4 10513.6 10879.5 10980.7 10948.3 11091.6 11112.3 11417.8 11597.1 10535.4 10888.7 11078.8 11273.5 11284.0 9091.5 9123.5 9324.5 9801.5 10168.2 8725.8 8814.9 9009.5 9558.4 9585.1 06:09:07 INFO - PROCESS | 26661 | -------- Summary: end -------- 06:09:07 INFO - PROCESS | 26661 | 06:09:07 INFO - TEST-INFO | 26661: exit 0 06:09:07 INFO - TEST-OK | dromaeo_css | took 1110217ms 06:09:07 INFO - TEST-START | kraken 06:09:07 INFO - operating with platform_type : linux_ 06:09:07 INFO - Initialising browser for kraken test... 06:09:07 INFO - TEST-INFO | started process 26894 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp6vwCwh/profile http://localhost:55315/getInfo.html) 06:09:11 INFO - PROCESS | 26894 | 06:09:11 INFO - PROCESS | 26894 | (process:26965): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:09:12 INFO - PROCESS | 26894 | __metrics Screen width/height:1600/1200 06:09:12 INFO - PROCESS | 26894 | colorDepth:24 06:09:12 INFO - PROCESS | 26894 | Browser inner width/height: 1024/697 06:09:12 INFO - PROCESS | 26894 | __metrics 06:09:13 INFO - TEST-INFO | 26894: exit 0 06:09:13 INFO - Browser initialized. 06:09:13 INFO - Running cycle 1/1 for kraken test... 06:09:13 INFO - TEST-INFO | started process 27016 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp6vwCwh/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:09:14 INFO - PROCESS | 27016 | 06:09:14 INFO - PROCESS | 27016 | (process:27074): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:09:25 INFO - PROCESS | 27016 | RSS: Main: 158031872 06:09:25 INFO - PROCESS | 27016 | 06:09:27 INFO - PROCESS | 27016 | Cycle 1(1): loaded http://localhost:55315/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55315/tests/kraken/driver.html?testName=audio-beat-detection) 06:09:28 INFO - PROCESS | 27016 | RSS: Main: 162873344 06:09:28 INFO - PROCESS | 27016 | 06:09:31 INFO - PROCESS | 27016 | Cycle 1(1): loaded http://localhost:55315/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55315/tests/kraken/driver.html?testName=audio-dft) 06:09:31 INFO - PROCESS | 27016 | RSS: Main: 168050688 06:09:31 INFO - PROCESS | 27016 | 06:09:34 INFO - PROCESS | 27016 | Cycle 1(1): loaded http://localhost:55315/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55315/tests/kraken/driver.html?testName=audio-fft) 06:09:35 INFO - PROCESS | 27016 | RSS: Main: 160837632 06:09:35 INFO - PROCESS | 27016 | 06:09:37 INFO - PROCESS | 27016 | Cycle 1(1): loaded http://localhost:55315/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55315/tests/kraken/driver.html?testName=audio-oscillator) 06:09:37 INFO - PROCESS | 27016 | RSS: Main: 161280000 06:09:37 INFO - PROCESS | 27016 | 06:09:40 INFO - PROCESS | 27016 | Cycle 1(1): loaded http://localhost:55315/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55315/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:09:40 INFO - PROCESS | 27016 | RSS: Main: 162320384 06:09:40 INFO - PROCESS | 27016 | 06:09:43 INFO - PROCESS | 27016 | Cycle 1(1): loaded http://localhost:55315/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55315/tests/kraken/driver.html?testName=imaging-darkroom) 06:09:44 INFO - PROCESS | 27016 | RSS: Main: 160628736 06:09:44 INFO - PROCESS | 27016 | 06:09:47 INFO - PROCESS | 27016 | Cycle 1(1): loaded http://localhost:55315/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55315/tests/kraken/driver.html?testName=imaging-desaturate) 06:09:48 INFO - PROCESS | 27016 | RSS: Main: 160931840 06:09:48 INFO - PROCESS | 27016 | 06:09:51 INFO - PROCESS | 27016 | Cycle 1(1): loaded http://localhost:55315/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55315/tests/kraken/driver.html?testName=json-parse-financial) 06:09:51 INFO - PROCESS | 27016 | RSS: Main: 161181696 06:09:51 INFO - PROCESS | 27016 | 06:09:53 INFO - PROCESS | 27016 | Cycle 1(1): loaded http://localhost:55315/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55315/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:09:53 INFO - PROCESS | 27016 | RSS: Main: 161976320 06:09:53 INFO - PROCESS | 27016 | 06:09:55 INFO - PROCESS | 27016 | Cycle 1(1): loaded http://localhost:55315/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55315/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:09:56 INFO - PROCESS | 27016 | RSS: Main: 160104448 06:09:56 INFO - PROCESS | 27016 | 06:09:58 INFO - PROCESS | 27016 | Cycle 1(1): loaded http://localhost:55315/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55315/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:09:59 INFO - PROCESS | 27016 | RSS: Main: 160620544 06:09:59 INFO - PROCESS | 27016 | 06:10:01 INFO - PROCESS | 27016 | Cycle 1(1): loaded http://localhost:55315/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55315/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:10:02 INFO - PROCESS | 27016 | RSS: Main: 160780288 06:10:02 INFO - PROCESS | 27016 | 06:10:04 INFO - PROCESS | 27016 | Cycle 1(1): loaded http://localhost:55315/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55315/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:10:05 INFO - PROCESS | 27016 | RSS: Main: 162697216 06:10:05 INFO - PROCESS | 27016 | 06:10:07 INFO - PROCESS | 27016 | Cycle 1(1): loaded http://localhost:55315/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55315/tests/kraken/driver.html?testName=ai-astar) 06:10:07 INFO - PROCESS | 27016 | RSS: Main: 162656256 06:10:07 INFO - PROCESS | 27016 | 06:10:07 INFO - PROCESS | 27016 | __start_tp_report 06:10:07 INFO - PROCESS | 27016 | _x_x_mozilla_page_load 06:10:07 INFO - PROCESS | 27016 | _x_x_mozilla_page_load_details 06:10:07 INFO - PROCESS | 27016 | |i|pagename|runs| 06:10:07 INFO - PROCESS | 27016 | |0;ai-astar;112;109;115;111;113;125;114;111;113;113 06:10:07 INFO - PROCESS | 27016 | |1;audio-beat-detection;157;126;156;164;128;162;160;134;172;133 06:10:07 INFO - PROCESS | 27016 | |2;audio-dft;163;163;163;163;162;163;167;175;168;163 06:10:07 INFO - PROCESS | 27016 | |3;audio-fft;74;74;73;151;73;75;74;73;143;74 06:10:07 INFO - PROCESS | 27016 | |4;audio-oscillator;96;97;154;96;97;97;138;97;97;146 06:10:07 INFO - PROCESS | 27016 | |5;imaging-gaussian-blur;120;117;115;116;116;115;116;116;115;116 06:10:07 INFO - PROCESS | 27016 | |6;imaging-darkroom;148;146;147;147;147;147;148;147;146;149 06:10:07 INFO - PROCESS | 27016 | |7;imaging-desaturate;97;97;97;97;102;97;97;96;96;98 06:10:07 INFO - PROCESS | 27016 | |8;json-parse-financial;58;59;57;64;57;57;67;64;57;57 06:10:07 INFO - PROCESS | 27016 | |9;json-stringify-tinderbox;66;68;66;68;67;66;67;68;67;67 06:10:07 INFO - PROCESS | 27016 | |10;stanford-crypto-aes;83;84;84;91;85;86;84;83;85;85 06:10:07 INFO - PROCESS | 27016 | |11;stanford-crypto-ccm;116;127;120;119;124;120;121;126;117;120 06:10:07 INFO - PROCESS | 27016 | |12;stanford-crypto-pbkdf2;144;144;145;152;154;141;154;155;156;141 06:10:07 INFO - PROCESS | 27016 | |13;stanford-crypto-sha256-iterative;73;69;70;69;70;70;71;69;70;71 06:10:07 INFO - PROCESS | 27016 | __end_tp_report 06:10:07 INFO - PROCESS | 27016 | __start_cc_report 06:10:07 INFO - PROCESS | 27016 | _x_x_mozilla_cycle_collect,755 06:10:07 INFO - PROCESS | 27016 | __end_cc_report 06:10:07 INFO - PROCESS | 27016 | __startTimestamp1455718207260__endTimestamp 06:10:07 INFO - PROCESS | 27016 | 06:10:07 INFO - PROCESS | 27016 | ------- Summary: start ------- 06:10:07 INFO - PROCESS | 27016 | Number of tests: 14 06:10:07 INFO - PROCESS | 27016 | 06:10:07 INFO - PROCESS | 27016 | [#0] ai-astar Cycles:10 Average:113.60 Median:113.00 stddev:4.35 (3.9%) stddev-sans-first:4.58 06:10:07 INFO - PROCESS | 27016 | Values: 112.0 109.0 115.0 111.0 113.0 125.0 114.0 111.0 113.0 113.0 06:10:07 INFO - PROCESS | 27016 | 06:10:07 INFO - PROCESS | 27016 | [#1] audio-beat-detection Cycles:10 Average:149.20 Median:158.50 stddev:17.02 (10.7%) stddev-sans-first:17.82 06:10:07 INFO - PROCESS | 27016 | Values: 157.0 126.0 156.0 164.0 128.0 162.0 160.0 134.0 172.0 133.0 06:10:07 INFO - PROCESS | 27016 | 06:10:07 INFO - PROCESS | 27016 | [#2] audio-dft Cycles:10 Average:165.00 Median:163.00 stddev:4.03 (2.5%) stddev-sans-first:4.21 06:10:07 INFO - PROCESS | 27016 | Values: 163.0 163.0 163.0 163.0 162.0 163.0 167.0 175.0 168.0 163.0 06:10:07 INFO - PROCESS | 27016 | 06:10:07 INFO - PROCESS | 27016 | [#3] audio-fft Cycles:10 Average:88.40 Median:74.00 stddev:30.95 (41.8%) stddev-sans-first:32.38 06:10:07 INFO - PROCESS | 27016 | Values: 74.0 74.0 73.0 151.0 73.0 75.0 74.0 73.0 143.0 74.0 06:10:07 INFO - PROCESS | 27016 | 06:10:07 INFO - PROCESS | 27016 | [#4] audio-oscillator Cycles:10 Average:111.50 Median:97.00 stddev:24.11 (24.9%) stddev-sans-first:24.91 06:10:07 INFO - PROCESS | 27016 | Values: 96.0 97.0 154.0 96.0 97.0 97.0 138.0 97.0 97.0 146.0 06:10:07 INFO - PROCESS | 27016 | 06:10:07 INFO - PROCESS | 27016 | [#5] imaging-gaussian-blur Cycles:10 Average:116.20 Median:116.00 stddev:1.48 (1.3%) stddev-sans-first:0.67 06:10:07 INFO - PROCESS | 27016 | Values: 120.0 117.0 115.0 116.0 116.0 115.0 116.0 116.0 115.0 116.0 06:10:07 INFO - PROCESS | 27016 | 06:10:07 INFO - PROCESS | 27016 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 06:10:07 INFO - PROCESS | 27016 | Values: 148.0 146.0 147.0 147.0 147.0 147.0 148.0 147.0 146.0 149.0 06:10:07 INFO - PROCESS | 27016 | 06:10:07 INFO - PROCESS | 27016 | [#7] imaging-desaturate Cycles:10 Average:97.40 Median:97.00 stddev:1.71 (1.8%) stddev-sans-first:1.81 06:10:07 INFO - PROCESS | 27016 | Values: 97.0 97.0 97.0 97.0 102.0 97.0 97.0 96.0 96.0 98.0 06:10:07 INFO - PROCESS | 27016 | 06:10:07 INFO - PROCESS | 27016 | [#8] json-parse-financial Cycles:10 Average:59.70 Median:58.50 stddev:3.80 (6.5%) stddev-sans-first:3.98 06:10:07 INFO - PROCESS | 27016 | Values: 58.0 59.0 57.0 64.0 57.0 57.0 67.0 64.0 57.0 57.0 06:10:07 INFO - PROCESS | 27016 | 06:10:07 INFO - PROCESS | 27016 | [#9] json-stringify-tinderbox Cycles:10 Average:67.00 Median:67.00 stddev:0.82 (1.2%) stddev-sans-first:0.78 06:10:07 INFO - PROCESS | 27016 | Values: 66.0 68.0 66.0 68.0 67.0 66.0 67.0 68.0 67.0 67.0 06:10:07 INFO - PROCESS | 27016 | 06:10:07 INFO - PROCESS | 27016 | [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:85.00 stddev:2.31 (2.7%) stddev-sans-first:2.33 06:10:07 INFO - PROCESS | 27016 | Values: 83.0 84.0 84.0 91.0 85.0 86.0 84.0 83.0 85.0 85.0 06:10:07 INFO - PROCESS | 27016 | 06:10:07 INFO - PROCESS | 27016 | [#11] stanford-crypto-ccm Cycles:10 Average:121.00 Median:120.50 stddev:3.62 (3.0%) stddev-sans-first:3.36 06:10:07 INFO - PROCESS | 27016 | Values: 116.0 127.0 120.0 119.0 124.0 120.0 121.0 126.0 117.0 120.0 06:10:07 INFO - PROCESS | 27016 | 06:10:07 INFO - PROCESS | 27016 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.60 Median:153.00 stddev:6.11 (4.0%) stddev-sans-first:6.25 06:10:07 INFO - PROCESS | 27016 | Values: 144.0 144.0 145.0 152.0 154.0 141.0 154.0 155.0 156.0 141.0 06:10:07 INFO - PROCESS | 27016 | 06:10:07 INFO - PROCESS | 27016 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:70.00 stddev:1.23 (1.8%) stddev-sans-first:0.78 06:10:07 INFO - PROCESS | 27016 | Values: 73.0 69.0 70.0 69.0 70.0 70.0 71.0 69.0 70.0 71.0 06:10:07 INFO - PROCESS | 27016 | -------- Summary: end -------- 06:10:07 INFO - PROCESS | 27016 | 06:10:08 INFO - TEST-INFO | 27016: exit 0 06:10:08 INFO - TEST-OK | kraken | took 60426ms 06:10:08 INFO - SUITE-END | took 1170s 06:10:08 INFO - Completed test suite (00:19:30) 06:10:08 INFO - Working with test: dromaeo_css 06:10:08 INFO - Generating results file: dromaeo_css 06:10:08 INFO - Working with test: kraken 06:10:08 INFO - Generating results file: kraken 06:10:08 INFO - javascript benchmark 06:10:08 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:10:08 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 06:10:08 INFO - process_Request line: dromaeo_css 6990.30 graph.html#tests=[[72,1,43]] 06:10:08 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:10:08 INFO - process_Request line: kraken 1540.00 graph.html#tests=[[232,1,43]] 06:10:08 INFO - RETURN: dromaeo_css: 6990.30 06:10:08 INFO - RETURN: kraken: 1540.00 06:10:08 INFO - javascript benchmark 06:10:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3138.748900087993, 3150.6376766671833, 3163.8734450621946, 3192.872285108596, 3200.2799370141715, 5096.770645320956, 5122.359705036871, 5124.820631277897, 5189.273501709759, 5212.2963399941, 5173.0, 5258.027264955986, 5303.628745987782, 5304.840854774353, 5308.867278318044, 4807.711537307755, 4860.902781944359, 4866.902661946759, 4962.677425967318, 4966.329545511364, 4765.0946320199055, 4955.801767929296, 4992.700437973715, 4998.675086119409, 5041.243813427996, 4662.254039353704, 4733.739644319561, 4769.356136921506, 4774.4509381420885, 4775.2598347256235, 4821.156297647933, 4827.444843842968, 4849.490803465621, 4854.344663470457, 4862.95137048632, 4766.451858036336, 4781.426228852525, 4839.153148199051, 4857.0, 4879.292502587141, 5014.724190169539, 5062.417821950449, 5089.1094058539975, 5102.285680004802, 5136.280920671109, 5569.331680198362, 5617.297837770278, 5618.185363122365, 5627.296587926509, 5670.3479099903625, 5506.669599824023, 5589.105743081128, 5591.860203494904, 5596.972015139939, 5604.3835178130375, 5352.866178345534, 5353.0899747043095, 5373.113436283009, 5380.704061276589, 5383.75773090208, 5874.73563689635, 5919.378465261172, 5924.822255332347, 5928.703564821742, 5938.732757025944, 5652.886942261214, 5681.602287839812, 5702.429757024264, 5711.200431939532, 5713.171590119493, 5674.26234589509, 5764.337101233412, 5766.711664416763, 5767.942320576741, 5771.105478650816, 5533.391326954032, 5538.113901775697, 5588.692621905834, 5589.74846131925, 5623.8875222496135, 5620.100783874561, 5648.293963254593, 5689.061304884731, 5694.174344719992, 5724.885502289931, 4341.6526677865695, 4389.62688171509, 4431.180231657154, 4441.888952776207, 4470.8435204767675, 3905.72659913809, 3919.098607320332, 3926.489556357655, 3940.822662980173, 3964.702647301464, 5346.812861549827, 5363.490468405495, 5365.0, 5370.194470829407, 5391.541718953855, 5582.939241544093, 5656.0, 5671.546276297886, 5684.54523638108, 5759.510441612426, 5425.403205647375, 5425.620206585501, 5444.40111587725, 5458.61789674719, 5459.672419654833, 4907.779149938261, 4909.705417674951, 4921.188003979375, 4932.901341973212, 4966.751662416937, 5661.490465858093, 5914.8817023659285, 5948.67282299469, 5981.342052374235, 6019.879602408015, 5707.514861236841, 5707.942920570741, 5736.4550367715, 5762.855928601651, 5765.5675824314185, 5823.854403639943, 5853.9121913172185, 5957.970210148921, 5972.044472884318, 5977.790777322773, 5572.972135139298, 5583.162525621189, 5583.8883222336135, 5594.664320140804, 5616.69108199053, 5685.0, 5685.34618518859, 5721.828345149652, 5737.540996720336, 5741.110127930177, 5455.754491047833, 5484.917726234189, 5515.310586176728, 5617.634853734494, 5657.886842263214, 5485.122380419114, 5491.478309560585, 5512.889742205213, 5536.363318218457, 5540.722963851872, 5439.9456005441025, 5442.510174084351, 5449.618526703092, 5453.263809385682, 5496.120620700829, 5384.165454354425, 5548.223248745098, 5645.266115404971, 5669.234653321749, 5712.914306285492, 5375.435579264277, 5405.864853378697, 5446.291982042309, 5455.208994695826, 5463.125899856004], "unit": "score", "name": "dojo.html", "value": 5242.5663873730555}, {"lowerIsBetter": false, "replicates": [520.3807469111758, 537.9085555455574, 550.2846299810245, 566.2384093394384, 567.3645517020938, 34850.82574587127, 35022.82488587553, 35509.82245088771, 35649.108772280706, 35741.28517429653, 36865.63134368655, 37543.43684844723, 37563.0, 37585.812070939675, 37622.24755504888, 8395.664173433055, 8566.528840913747, 8572.914270857274, 8574.657013719443, 8620.698275560357, 8574.35692323075, 8727.0, 8748.518831464267, 8767.473951562895, 8798.164174403422, 8755.518446485441, 8795.912040879606, 8833.0, 8842.823143537158, 8858.069902660225, 8705.129487051276, 8727.301815854747, 8754.56227188638, 8785.0, 8786.912130878673, 8708.78228044304, 8849.292056635453, 8863.822723545558, 8867.0, 8867.73396798097, 37533.436998445046, 37552.24895502102, 37775.43336849949, 37846.43230351547, 37862.24275514474, 3200.695933886277, 3777.338965680995, 3952.980235098835, 4014.6788256939376, 4128.504579450455, 29290.41419171626, 29885.70114298851, 30050.24874378158, 30460.54309185342, 30465.0, 3977.184677141208, 4007.6793856491413, 4011.2579172852825, 4073.6944729145434, 4125.834966601333, 268919.0, 269730.0, 271010.999999998, 271512.0, 271997.0, 53093.73453132787, 58207.70896145492, 58735.0, 58908.410915890294, 59170.70414647985, 52543.73728131335, 52708.73645631824, 52914.206286905726, 53183.0, 53229.73385133049, 15944.521664350088, 15951.644110250758, 16151.0, 16189.19054047293, 16250.75623865643, 11708.648740537797, 11743.588974385855, 11799.115066370057, 11928.880711192951, 11984.101192410604, 19236.326728564432, 20337.288194913108, 20532.07605657749, 20580.0, 20708.0, 7470.252974702486, 7592.924070759222, 7615.428842836809, 7673.0, 7768.572728499874, 850.5832142250376, 932.3333816321227, 936.1714882329188, 997.2620261006803, 998.1864780204111, 27956.86021569879, 28284.292892677848, 28744.568831467546, 29003.12990610285, 29399.85300073486, 1030.4229631406436, 1064.1486810551528, 1091.2034215022918, 1148.586508856811, 1150.1316506037888, 15448.613784655474, 15582.688346233012, 15597.68804623901, 15875.444359447594, 16100.597485062966, 386077.0, 392257.0, 393619.0, 393687.0, 394845.0, 55592.72203638956, 56332.718336408056, 56512.43487565154, 56639.0, 56857.431425685216, 1315.2963164707028, 1322.1868550841164, 1335.3123141582093, 1358.9048766586245, 1362.1826903857805, 29687.85156074206, 30582.541261880644, 30906.845465773426, 30912.536311955788, 31346.843265783526, 47310.52689473061, 48067.27899081447, 48080.5191948076, 48171.5182848167, 48314.0, 280796.0, 282052.0, 282479.0, 283925.0, 284545.0, 30550.84724576452, 44214.778926105166, 44645.77677111594, 44810.327845081694, 45969.77015115037, 39888.2022359557, 39959.0, 40448.1910361797, 40650.39024414577, 40687.0, 34295.485567717005, 34413.65586344204, 34904.65095349014, 34980.30039399147, 38477.422838658, 37041.51833926613, 37229.62770372262, 37554.24891502209, 37717.2456550862, 37946.24107517889, 34943.475847862814, 35148.472772908935, 35240.47139292964, 35543.11142221465, 35897.28205435929, 31318.68681313158, 31526.0, 33699.494507582895, 33857.0, 33955.4906676405, 25234.855037322035, 25689.743102568737, 25823.354416139748, 26005.0, 26031.869840650674], "unit": "score", "name": "ext.html", "value": 18697.520395983298}, {"lowerIsBetter": false, "replicates": [363.3931334671099, 367.89514988228353, 369.59529315399635, 369.6082152917907, 369.8520591763296, 11558.711032224199, 12064.939675301634, 15996.68006639868, 16293.0, 16723.91638041811, 17203.311867525314, 17327.0, 17551.736723949118, 17599.472015839547, 17605.82394176058, 5945.732442040118, 6213.161223234873, 6257.124002639634, 6263.248410190783, 6270.278917924428, 5985.461308482236, 6111.908321375183, 6125.754969801203, 6162.476189523896, 6197.5351848611535, 4467.41923549938, 6149.631022138686, 6161.907571386433, 6728.250654829731, 6967.163940327143, 6770.69531871067, 6913.343232392915, 6926.58440493572, 6929.861402771941, 7107.6090815005155, 6685.866282674319, 6752.257251702309, 6761.560498567626, 6798.150231221098, 6798.626075565842, 22205.22281720132, 22893.542129157322, 23108.0756769729, 23202.883985580134, 23208.187713430118, 2208.514126892081, 2271.965920511194, 2306.6078766609717, 2417.0452671194957, 2714.4571085782727, 9733.610655573768, 13671.589852304447, 14572.70854582913, 14644.41422343105, 14734.557963261119, 2019.8788072715683, 2034.8575599708026, 2070.4306315763133, 2100.2019232691478, 2119.0782009825775, 70029.0, 72281.63859180723, 72388.63805680991, 73066.0, 73285.6335718318, 15309.157996310087, 15636.374545018072, 15809.0, 15841.762373564407, 15933.442329518411, 24008.27975160748, 24105.156319529084, 24632.0, 24650.876745616515, 24776.504469910862, 6986.54587451814, 7258.056452661121, 7631.732889348847, 7688.38492920565, 7715.421343399267, 7360.852782944311, 7362.411007119417, 7376.557406555624, 7411.110666720028, 7436.40508759298, 4517.457905051415, 4594.379758732595, 4608.331791890158, 4612.930806037912, 4618.0, 1814.4284550366592, 1853.3605905962422, 1868.588910439701, 1880.7555017847867, 1911.149538455374, 867.4058270085012, 953.3707752883203, 965.0494263150791, 1000.6347683095618, 1048.7849990751877, 16261.837381626032, 17306.567335816453, 17394.826051739572, 17935.910320448314, 18059.2776288947, 448.5357654827303, 455.4602795687121, 465.1534207741945, 470.6399604302711, 470.8846332648523, 6041.758329666852, 6105.481034112061, 6250.9062364064575, 6272.0, 6336.746530138743, 525074.0, 526784.8303792436, 526819.0, 557381.0, 595426.0, 76782.0, 78670.0, 79990.0, 80579.59710201412, 80796.59601702071, 533.6291277562135, 535.7669413804929, 537.946205379451, 543.3751186135976, 544.0479161467432, 10335.689929302132, 10696.51618141385, 10784.676459706221, 10833.729156771144, 10868.78262434731, 33720.32559348848, 34650.0, 34901.8254908734, 34958.475622866186, 35281.47077793784, 44764.0, 45215.0, 49214.26178607252, 49359.75320123376, 49488.75255623699, 7950.562719050507, 8209.466384684976, 8259.669613215645, 8306.70926517569, 8338.583070846313, 11324.547018119512, 12385.19496232742, 12693.492260309853, 12725.872741272839, 12960.611181664564, 9806.509674516103, 9811.362261452983, 9868.0, 10246.897531024595, 10514.421706806199, 10373.844392333971, 10625.787484250117, 10666.146708263475, 10692.518836652525, 10906.400147991619, 10769.461526923778, 10945.129994574265, 11122.332660040423, 11288.2662626929, 11396.259243149168, 7430.777076687708, 8168.8366232673825, 8301.169883011651, 8334.12491688364, 8340.541270230196, 10140.0, 10234.437105959243, 10425.113865321533, 10482.213833962636, 10541.841872372073], "unit": "score", "name": "jquery.html", "value": 8584.697893767108}, {"lowerIsBetter": false, "replicates": [1476.3135142158894, 1489.3744627256553, 1645.6215070533776, 1767.6376342849717, 1769.4603146040452, 6800.081988931493, 7371.926280737191, 7496.81257968551, 7540.245975402464, 7598.810029749252, 7370.447216458773, 7468.066491688539, 7506.96246518768, 7510.1738808731, 7512.66193021314, 2203.3389983005072, 2228.7771222877745, 2230.620794464937, 2237.407087121914, 2240.4622890506325, 2212.8451008429415, 2218.001899145383, 2277.840551161419, 2280.247518318951, 2281.178775640768, 1951.541387773872, 2193.0, 2217.73387193537, 2225.2434172381386, 2230.308604332662, 2184.060853832851, 2236.865788052722, 2263.196565219348, 2267.580497607931, 2268.8638681679154, 2223.5108276179217, 2236.105557776902, 2237.093976939342, 2240.19353032908, 2243.3270018994235, 7346.96326518364, 7374.852502949964, 7396.3713084387355, 7400.555966642019, 7416.369608583277, 4636.629069674418, 4760.857174284777, 4765.142274390609, 4792.113459010095, 4795.6403269754555, 3053.7404320632772, 3110.0, 3187.15540381799, 3213.2127628730877, 3237.190702324419, 946.3895787217207, 952.2667545989618, 983.311681822727, 984.5421878826309, 1028.2596530498029, 10251.436171010591, 10280.177585793193, 10309.226807989357, 10319.690409287658, 10380.688579342632, 4257.914841703148, 4301.419308393327, 4332.566743325642, 4358.302671572533, 4366.257736184856, 8804.647814087493, 8831.735047948572, 8848.1151884811, 8868.955655221682, 8885.511296878605, 4803.1114243864995, 4815.831445899376, 4823.03539292143, 4831.685940413862, 4854.902901941941, 4356.823657612427, 4379.890502737457, 4387.583179597933, 4409.933850992237, 4412.646988240933, 3520.9471857922154, 3560.359135355609, 3561.1631266652316, 3563.8773786257248, 3601.3517566838223, 1154.0825044089968, 1167.9299242045504, 1172.0857730969858, 1178.5462596900084, 1180.114913814639, 891.1934699097327, 1007.3200589601989, 1036.8392899100652, 1102.3165637304921, 1317.2623330934707, 6985.720571177198, 7041.436685065182, 7068.974998625171, 7076.080109585824, 7078.292170782881, 1095.3482677806692, 1095.9890401095886, 1100.3287994323457, 1123.764009558002, 1138.743782648914, 5571.498565129077, 5619.297587801525, 5660.462256085665, 5684.459976302244, 5700.629459085229, 8836.072212417603, 9188.0, 9239.538023098818, 9249.90750092504, 9254.814903701888, 9051.411658242194, 9126.771830704152, 9127.041660625538, 9214.308926830514, 9234.122758337948, 6910.585364878123, 6934.271901450275, 7052.753153639701, 7082.858342833218, 7083.079199704005, 7180.640967951686, 7279.854402911807, 7300.0, 7324.670389832577, 7337.963310183629, 7837.373010159287, 8164.550949697824, 8301.875471867806, 8304.709335173482, 8368.7907802303, 8240.258376746122, 8341.374396920133, 8361.665533378597, 8432.114627963976, 8447.366447516584, 6598.571092878948, 6827.931720682928, 6851.109355783916, 6852.794416167323, 6877.58734475933, 7337.229590892879, 7343.0, 7396.445266604918, 7404.962975185305, 7409.629518523944, 6111.54163437735, 6929.7228110875, 7023.683934223074, 7047.859042819217, 7233.529820561646, 6916.896246556406, 6955.23492415844, 6964.512484126062, 7038.753643622448, 7085.929140708527, 6888.793336199922, 7066.328698773608, 7074.646267686698, 7086.078809754699, 7091.893621595577, 6509.934900650933, 6583.275839657729, 6584.242812076481, 6586.769463068769, 6597.109390232449, 5957.374475680164, 5982.551308651781, 5983.563944653339, 5988.251468566429, 6150.876982460415], "unit": "score", "name": "mootools.html", "value": 4420.557487670313}, {"lowerIsBetter": false, "replicates": [343.56195850290874, 344.5193954433567, 346.668931170732, 347.4822514453464, 348.82733047141653, 6095.3599872013465, 6198.5041196704215, 6209.503239740821, 6271.122042913984, 6304.275008374038, 6242.937570624293, 6249.531285153609, 6262.780802671896, 6266.84332891678, 6271.498280137589, 4767.594754445876, 4780.8565743027675, 4790.161721698706, 4794.400699912511, 4803.3995750531185, 4793.328933949232, 4799.952000479985, 4803.63972702047, 4814.1334559779225, 4815.66290359675, 4678.485366609671, 4803.231482962727, 4804.87987800306, 4808.374911261531, 4814.0371925614845, 4806.086843499724, 4808.302796094564, 4813.711177329354, 4825.20384136617, 4826.131296366652, 4231.809568569422, 4236.830526778926, 4242.66058715302, 4249.447571815645, 4254.212970600449, 5926.851828704317, 5930.169776231331, 5931.673757943311, 5933.3473317934995, 5944.138099975523, 5519.089350257203, 5638.126090455986, 5641.774329026834, 5650.0, 5657.12314591239, 6633.872241718919, 6645.501587380966, 6657.633830139341, 6659.733610655568, 6660.666966651696, 4670.136024835382, 4680.812767489297, 4686.0, 4693.460252070987, 4701.294805779126, 6713.731450741964, 6964.616946068015, 6965.407940325078, 6980.092587963532, 7004.47466440014, 4621.976890115528, 4636.35091087248, 4639.86080417588, 4644.465886423037, 4646.372739680168, 4692.343071969927, 4696.483386827446, 4698.788554515055, 4699.224627936421, 4704.976475117603, 5470.91793623096, 5476.315460567429, 5479.671219726829, 5484.985277723634, 5488.69812160327, 6538.411542961157, 6671.933280667228, 6688.7324507019175, 6698.531102822755, 6699.933000669931, 1610.1627153879917, 1644.7121753693295, 1646.8929519581188, 1651.1331550935615, 1652.396875140565, 1096.2107282756403, 1097.0839349143396, 1112.9721756955978, 1116.6538373104363, 1121.377635412354, 6133.539984501181, 6229.501639868799, 6233.252009758858, 6267.122602835607, 6277.435030847246, 6760.898586521206, 6771.223798242697, 6794.320567943265, 6799.150106236721, 6800.183977922582, 6142.969285153546, 6222.533310001768, 6241.375862413813, 6248.781292654735, 6251.0, 3662.102784817737, 3666.395044817629, 3680.8159592020293, 3680.9079773005355, 3686.4286035664513, 7128.714851405885, 7149.0, 7151.427885769126, 7158.498905076699, 7160.033395491646, 6754.729810807513, 6970.372666460043, 6975.965120174366, 6995.300469953066, 7001.544899581511, 7100.396466300319, 7106.5736055836815, 7109.502334836512, 7112.679929403189, 7125.714971401189, 6742.123523941857, 6747.460203183636, 6749.493787965824, 6761.357671021246, 6797.388235058868, 6517.608943463218, 6611.305812889577, 6637.402633762791, 6639.834004149935, 6652.767153149616, 6919.20429150634, 6925.238223795278, 6941.062956500808, 6950.0, 6962.3037696231995, 4615.515370886143, 4655.813767449399, 4662.976685116552, 4664.300354946649, 4668.626509879269, 6619.867602648016, 6768.492363072691, 6779.830504237236, 6788.558743681645, 6816.2842901496615, 6709.865802683821, 6716.059751634677, 6731.057651928832, 6739.359760822714, 6749.5612785168805, 6693.933060669331, 6701.932980670131, 6711.530192886451, 6721.663916804238, 6730.32696730323, 6450.0, 6572.211334639874, 6594.10979517759, 6653.600783952978, 6681.465482761465, 6743.089682892747, 6759.493038022267, 6765.154355705537, 6766.289539598468, 6778.694958726967, 6555.049517819794, 6576.375244351779, 6576.8355791105605, 6602.7689030883685, 6607.306232845482], "unit": "score", "name": "prototype.html", "value": 4993.9658305233315}, {"lowerIsBetter": false, "replicates": [638.3488841381794, 642.8939225027867, 758.3175142371863, 768.4851149729681, 794.3089512124451, 13806.930965345171, 13948.372323245465, 14068.718625627482, 14138.293085345716, 14153.646158846033, 13329.866701332983, 13349.733005339887, 13369.465221391132, 13381.59855204343, 13405.731885362287, 659.0904551718634, 806.4717609965483, 806.4757907360204, 806.8830019647177, 808.5472135604051, 790.1979490816825, 791.8455901099288, 792.1009654042674, 794.8410317936407, 795.2643804480832, 824.2952275804191, 825.3149885594971, 830.6303694855792, 832.4921797703396, 833.1834801894147, 827.1067247372853, 827.4786884262905, 829.4111181061423, 832.6627715775121, 834.6661335465801, 603.5594016368032, 604.2115039872964, 604.8699529601113, 605.4974371271834, 605.5397897597813, 13805.654858628615, 13843.653908652264, 13862.792058119136, 13933.164010159422, 13941.651458713613, 12845.935770321183, 13269.270190139538, 13643.02984660505, 13687.931560342235, 13743.381547830371, 10462.790744185073, 10597.470126493645, 10803.13574914005, 10877.891221087766, 11205.551777928873, 3642.8724994625327, 3695.575008873987, 3739.383001804699, 3750.1749615084636, 3803.0112170835782, 47387.52612473866, 47798.52201477975, 48185.277220841715, 48274.27588586174, 48545.27182092236, 9123.315751318678, 9375.390599611004, 9648.75878103053, 9770.560324785401, 9876.40741555509, 18697.15862786178, 18881.339153129575, 18882.24471021144, 18885.716714249298, 18971.956542390024, 7554.584497852561, 7790.727324543614, 7839.804004899809, 7920.6039698014865, 8130.471519351223, 4338.262495375794, 4437.866863994085, 4449.176902273025, 4450.977745111254, 4465.910681786411, 3109.284864481182, 3135.0, 3138.6076740407448, 3146.3392687535415, 3149.5590617313596, 532.052945756554, 562.3420597900466, 563.0596903171713, 574.1129954220739, 584.5031723035386, 578.531389574446, 662.2582212220063, 698.7100353353302, 703.2229386527813, 741.5143081281769, 8424.663013479514, 8681.088485709037, 8710.0, 8752.91247087521, 8764.123587641185, 515.1885779896678, 540.6620861961275, 672.9697163627649, 682.4165338635395, 696.7108649910332, 3901.2496190185852, 4056.371262454324, 4151.501819781645, 4245.936310955338, 4262.381954616563, 52722.20916686253, 54033.72983135059, 54755.726221369434, 54860.451395486336, 54885.451145488834, 49886.25170622444, 50559.0, 50868.23697644538, 53937.1909421359, 55065.1740223897, 44678.0, 45463.54536454659, 45721.7713911435, 46504.3024354635, 46767.999999999316, 8727.65089396417, 8729.607167677343, 8980.550972451481, 9010.549472526216, 9033.683821066232, 33626.32747344991, 34730.0, 34999.475007875415, 35461.46807797936, 35914.820425898746, 39392.2121557573, 39937.40093898652, 41678.79160604178, 42544.57455425406, 42945.35581966335, 10798.622048228275, 11131.220814542905, 11204.215704900578, 11253.381064041228, 11416.31502109876, 11814.468348924147, 11854.822177667515, 11881.287122772315, 11984.46069926838, 12322.260664360167, 10370.740731481774, 10505.369677819355, 10513.632022879163, 10879.456027198767, 10980.725481863017, 10948.288361256493, 11091.611793587508, 11112.333260004425, 11417.828732568853, 11597.07223422141, 10535.367877927349, 10888.727781805519, 11078.778424431304, 11273.549058037586, 11284.0, 9091.499967501852, 9123.489096573208, 9324.487153206639, 9801.460919649488, 10168.237382196512, 8725.781855453664, 8814.91185088141, 9009.549522523717, 9558.378705384128, 9585.137337639646], "unit": "score", "name": "yui.html", "value": 6280.028848535558}], "name": "dromaeo_css", "value": 6990.301534507474}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 109.0, 115.0, 111.0, 113.0, 125.0, 114.0, 111.0, 113.0, 113.0], "unit": "score", "name": "ai-astar", "value": 113.6}, {"lowerIsBetter": true, "replicates": [157.0, 126.0, 156.0, 164.0, 128.0, 162.0, 160.0, 134.0, 172.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 149.2}, {"lowerIsBetter": true, "replicates": [163.0, 163.0, 163.0, 163.0, 162.0, 163.0, 167.0, 175.0, 168.0, 163.0], "unit": "score", "name": "audio-dft", "value": 165.0}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 73.0, 151.0, 73.0, 75.0, 74.0, 73.0, 143.0, 74.0], "unit": "score", "name": "audio-fft", "value": 88.4}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 154.0, 96.0, 97.0, 97.0, 138.0, 97.0, 97.0, 146.0], "unit": "score", "name": "audio-oscillator", "value": 111.5}, {"lowerIsBetter": true, "replicates": [120.0, 117.0, 115.0, 116.0, 116.0, 115.0, 116.0, 116.0, 115.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.2}, {"lowerIsBetter": true, "replicates": [148.0, 146.0, 147.0, 147.0, 147.0, 147.0, 148.0, 147.0, 146.0, 149.0], "unit": "score", "name": "imaging-darkroom", "value": 147.2}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 97.0, 97.0, 102.0, 97.0, 97.0, 96.0, 96.0, 98.0], "unit": "score", "name": "imaging-desaturate", "value": 97.4}, {"lowerIsBetter": true, "replicates": [58.0, 59.0, 57.0, 64.0, 57.0, 57.0, 67.0, 64.0, 57.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 59.7}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 66.0, 68.0, 67.0, 66.0, 67.0, 68.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.0}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 84.0, 91.0, 85.0, 86.0, 84.0, 83.0, 85.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.0}, {"lowerIsBetter": true, "replicates": [116.0, 127.0, 120.0, 119.0, 124.0, 120.0, 121.0, 126.0, 117.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.0}, {"lowerIsBetter": true, "replicates": [144.0, 144.0, 145.0, 152.0, 154.0, 141.0, 154.0, 155.0, 156.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.6}, {"lowerIsBetter": true, "replicates": [73.0, 69.0, 70.0, 69.0, 70.0, 70.0, 71.0, 69.0, 70.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.2}], "name": "kraken", "value": 1539.9999999999998}]} 06:10:08 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1540.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6990.30"}}} 06:10:08 INFO - Return code: 0 06:10:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 06:10:08 INFO - # TBPL SUCCESS # 06:10:08 INFO - Running post-action listener: _resource_record_post_action 06:10:08 INFO - Running post-run listener: _resource_record_post_run 06:10:09 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 24576; Write bytes: 542748672; Read time: 272; Write time: 602996 06:10:09 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 240578560; Read time: 0; Write time: 351264 06:10:09 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 24576; Write bytes: 302112768; Read time: 272; Write time: 251716 06:10:09 INFO - Running post-run listener: _upload_blobber_files 06:10:09 INFO - Blob upload gear active. 06:10:09 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 06:10: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 06:10: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'] 06:10: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 06:10:10 INFO - (blobuploader) - INFO - Open directory for files ... 06:10:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:10:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:10:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:10:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:10:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:10:11 INFO - (blobuploader) - INFO - Done attempting. 06:10:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:10:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:10:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:10:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:10:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:10:12 INFO - (blobuploader) - INFO - Done attempting. 06:10:12 INFO - (blobuploader) - INFO - Iteration through files over. 06:10:12 INFO - Return code: 0 06:10:12 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 06:10:12 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 06:10:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/41075f7b98e67a1856d7ab9ae5d268694aca3b7a271943a88c00348a5e45b50c4b4efbbda63de43776ac1f7b8341951beffb410461420c8150d9ca6cfb1fa877", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36b195e372051f127b7c8e7d8377b0a9e812fb26c78c3c4a4675b0caa3a66480d8e67b7cba0141e65015554278c6cd4579eafcac305e855eae0a681c14cd948b"} 06:10:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 06:10:12 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 06:10:12 INFO - Contents: 06:10:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/41075f7b98e67a1856d7ab9ae5d268694aca3b7a271943a88c00348a5e45b50c4b4efbbda63de43776ac1f7b8341951beffb410461420c8150d9ca6cfb1fa877", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36b195e372051f127b7c8e7d8377b0a9e812fb26c78c3c4a4675b0caa3a66480d8e67b7cba0141e65015554278c6cd4579eafcac305e855eae0a681c14cd948b"} 06:10:12 INFO - Running post-run listener: copy_logs_to_upload_dir 06:10:12 INFO - Copying logs to upload dir... 06:10:12 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 06:10:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.789367 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-02-17 06:10:12.041082) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-17 06:10:12.044772) ========= 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=1b9da9da7504fe468691862d000001b9-1455716216.376648-1824933311 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/41075f7b98e67a1856d7ab9ae5d268694aca3b7a271943a88c00348a5e45b50c4b4efbbda63de43776ac1f7b8341951beffb410461420c8150d9ca6cfb1fa877", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36b195e372051f127b7c8e7d8377b0a9e812fb26c78c3c4a4675b0caa3a66480d8e67b7cba0141e65015554278c6cd4579eafcac305e855eae0a681c14cd948b"} build_url:https://queue.taskcluster.net/v1/task/NJdWzCIQTmeO9x8K7jWXXQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011545 build_url: 'https://queue.taskcluster.net/v1/task/NJdWzCIQTmeO9x8K7jWXXQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/41075f7b98e67a1856d7ab9ae5d268694aca3b7a271943a88c00348a5e45b50c4b4efbbda63de43776ac1f7b8341951beffb410461420c8150d9ca6cfb1fa877", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36b195e372051f127b7c8e7d8377b0a9e812fb26c78c3c4a4675b0caa3a66480d8e67b7cba0141e65015554278c6cd4579eafcac305e855eae0a681c14cd948b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-17 06:10:12.070710) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 06:10:12.071065) ========= 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=1b9da9da7504fe468691862d000001b9-1455716216.376648-1824933311 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004796 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 06:10:12.123245) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-17 06:10:12.123585) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-17 06:10:12.123871) ========= ========= Total master_lag: 0.20 =========