builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-012 starttime: 1460145676.12 results: success (0) buildid: 20160408103057 builduid: 82dbd6e4fd9049c1b148ee2af8093f6b revision: dbc96a62c1da23c6e31e6194617386767851d45a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-08 13:01:16.117785) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-08 13:01:16.118152) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-08 13:01:16.118743) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1460144889.796129-1899462580 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006491 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.07 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-08 13:01:16.192546) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-08 13:01:16.192848) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-08 13:01:16.338456) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 13:01:16.338955) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1460144889.796129-1899462580 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004571 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 13:01:16.421614) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-08 13:01:16.421891) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-08 13:01:16.422256) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 13:01:16.422542) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1460144889.796129-1899462580 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-08 13:01:17-- 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% 19.5M=0.001s 2016-04-08 13:01:17 (19.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096692 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 13:01:16.543588) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 13:01:16.543886) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1460144889.796129-1899462580 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019823 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 13:01:16.630540) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 13:01:16.630869) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev dbc96a62c1da23c6e31e6194617386767851d45a --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev dbc96a62c1da23c6e31e6194617386767851d45a --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=2c5dd2b0a310ecf02fd87158000001b4-1460144889.796129-1899462580 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-08 13:01:17,481 truncating revision to first 12 chars 2016-04-08 13:01:17,481 Setting DEBUG logging. 2016-04-08 13:01:17,481 attempt 1/10 2016-04-08 13:01:17,481 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/dbc96a62c1da?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-08 13:01:17,718 unpacking tar archive at: mozilla-inbound-dbc96a62c1da/testing/mozharness/ program finished with exit code 0 elapsedTime=0.499923 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 13:01:17.159556) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-08 13:01:17.159879) ========= echo dbc96a62c1da23c6e31e6194617386767851d45a in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'dbc96a62c1da23c6e31e6194617386767851d45a'] 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=2c5dd2b0a310ecf02fd87158000001b4-1460144889.796129-1899462580 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False dbc96a62c1da23c6e31e6194617386767851d45a program finished with exit code 0 elapsedTime=0.004733 script_repo_revision: 'dbc96a62c1da23c6e31e6194617386767851d45a' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-08 13:01:17.210128) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-08 13:01:17.213485) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-08 13:01:17.224487) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-04-08 13:01:17.224841) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1460144889.796129-1899462580 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:01:18 INFO - MultiFileLogger online at 20160408 13:01:18 in /builds/slave/test-pgo 13:01:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 13:01:18 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 13:01:18 INFO - {'append_to_log': False, 13:01:18 INFO - 'base_work_dir': '/builds/slave/test-pgo', 13:01:18 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 13:01:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 13:01:18 INFO - 'branch': 'Mozilla-Inbound', 13:01:18 INFO - 'buildbot_json_path': 'buildprops.json', 13:01:18 INFO - 'config_files': ('talos/linux_config.py',), 13:01:18 INFO - 'default_actions': ('clobber', 13:01:18 INFO - 'read-buildbot-config', 13:01:18 INFO - 'download-and-extract', 13:01:18 INFO - 'populate-webroot', 13:01:18 INFO - 'create-virtualenv', 13:01:18 INFO - 'install', 13:01:18 INFO - 'run-tests'), 13:01:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:01:18 INFO - 'download_minidump_stackwalk': True, 13:01:18 INFO - 'download_symbols': 'ondemand', 13:01:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:01:18 INFO - 'tooltool.py': '/tools/tooltool.py', 13:01:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:01:18 INFO - '/tools/misc-python/virtualenv.py')}, 13:01:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:01:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:01:18 INFO - 'installer_path': 'installer.exe', 13:01:18 INFO - 'log_level': 'info', 13:01:18 INFO - 'log_name': 'talos', 13:01:18 INFO - 'log_to_console': True, 13:01:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:01:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:01:18 INFO - 'opt_config_files': (), 13:01:18 INFO - 'pip_index': False, 13:01:18 INFO - 'sps_profile': False, 13:01:18 INFO - 'sps_profile_interval': 0, 13:01:18 INFO - 'suite': 'dromaeojs', 13:01:18 INFO - 'system_bits': '32', 13:01:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:01:18 INFO - 'title': 'talos-linux64-ix-012', 13:01:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:01:18 INFO - 'use_talos_json': True, 13:01:18 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 13:01:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:01:18 INFO - 'work_dir': 'build'} 13:01:18 INFO - ##### 13:01:18 INFO - ##### Running clobber step. 13:01:18 INFO - ##### 13:01:18 INFO - Running pre-action listener: _resource_record_pre_action 13:01:18 INFO - Running main action method: clobber 13:01:18 INFO - rmtree: /builds/slave/test-pgo/build 13:01:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 13:01:18 INFO - Running post-action listener: _resource_record_post_action 13:01:18 INFO - ##### 13:01:18 INFO - ##### Running read-buildbot-config step. 13:01:18 INFO - ##### 13:01:18 INFO - Running pre-action listener: _resource_record_pre_action 13:01:18 INFO - Running main action method: read_buildbot_config 13:01:18 INFO - Using buildbot properties: 13:01:18 INFO - { 13:01:18 INFO - "project": "", 13:01:18 INFO - "product": "firefox", 13:01:18 INFO - "script_repo_revision": "production", 13:01:18 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 13:01:18 INFO - "repository": "", 13:01:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 13:01:18 INFO - "buildid": "20160408103057", 13:01:18 INFO - "pgo_build": "True", 13:01:18 INFO - "basedir": "/builds/slave/test-pgo", 13:01:18 INFO - "buildnumber": 839, 13:01:18 INFO - "slavename": "talos-linux64-ix-012", 13:01:18 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:01:18 INFO - "platform": "ubuntu64_hw", 13:01:18 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 13:01:18 INFO - "branch": "mozilla-inbound", 13:01:18 INFO - "repo_path": "integration/mozilla-inbound", 13:01:18 INFO - "revision": "dbc96a62c1da23c6e31e6194617386767851d45a", 13:01:18 INFO - "stage_platform": "linux64-pgo", 13:01:18 INFO - "builduid": "82dbd6e4fd9049c1b148ee2af8093f6b", 13:01:18 INFO - "slavebuilddir": "test" 13:01:18 INFO - } 13:01:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/ANRvAcnGTIO10nxB5YdV9Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 13:01:18 INFO - Running post-action listener: _resource_record_post_action 13:01:18 INFO - ##### 13:01:18 INFO - ##### Running download-and-extract step. 13:01:18 INFO - ##### 13:01:18 INFO - Running pre-action listener: _resource_record_pre_action 13:01:18 INFO - Running main action method: download_and_extract 13:01:18 INFO - mkdir: /builds/slave/test-pgo/build/tests 13:01:18 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')]} 13:01:18 INFO - https://queue.taskcluster.net/v1/task/ANRvAcnGTIO10nxB5YdV9Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:01:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANRvAcnGTIO10nxB5YdV9Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 13:01:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANRvAcnGTIO10nxB5YdV9Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 13:01:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANRvAcnGTIO10nxB5YdV9Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 13:01:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANRvAcnGTIO10nxB5YdV9Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:01:23 INFO - Downloaded 1361 bytes. 13:01:23 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 13:01:23 INFO - Using the following test package requirements: 13:01:23 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 13:01:23 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:01:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:01:23 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:01:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:01:23 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:01:23 INFO - u'jsshell-linux-x86_64.zip'], 13:01:23 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:01:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:01:23 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 13:01:23 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:01:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:01:23 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:01:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:01:23 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:01:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:01:23 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:01:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:01:23 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:01:23 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')]} 13:01:23 INFO - https://queue.taskcluster.net/v1/task/ANRvAcnGTIO10nxB5YdV9Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:01:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANRvAcnGTIO10nxB5YdV9Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 13:01:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANRvAcnGTIO10nxB5YdV9Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 13:01:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANRvAcnGTIO10nxB5YdV9Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 13:01:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANRvAcnGTIO10nxB5YdV9Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:01:24 INFO - Downloaded 23760456 bytes. 13:01:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 13:01:24 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 13:01:26 INFO - Return code: 0 13:01:26 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:01:26 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')]} 13:01:26 INFO - https://queue.taskcluster.net/v1/task/ANRvAcnGTIO10nxB5YdV9Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:01:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANRvAcnGTIO10nxB5YdV9Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 13:01:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANRvAcnGTIO10nxB5YdV9Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 13:01:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANRvAcnGTIO10nxB5YdV9Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 13:01:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANRvAcnGTIO10nxB5YdV9Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:01:41 INFO - Downloaded 23760456 bytes. 13:01:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 13:01:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 13:01:42 INFO - Return code: 0 13:01:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:01:42 INFO - https://queue.taskcluster.net/v1/task/ANRvAcnGTIO10nxB5YdV9Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:01:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANRvAcnGTIO10nxB5YdV9Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 13:01:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANRvAcnGTIO10nxB5YdV9Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 13:01:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANRvAcnGTIO10nxB5YdV9Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 13:01:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANRvAcnGTIO10nxB5YdV9Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:01:44 INFO - Downloaded 10841097 bytes. 13:01:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 13:01:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 13:01:44 INFO - Return code: 0 13:01:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:01:44 INFO - https://queue.taskcluster.net/v1/task/ANRvAcnGTIO10nxB5YdV9Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:01:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANRvAcnGTIO10nxB5YdV9Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 13:01:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANRvAcnGTIO10nxB5YdV9Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 13:01:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANRvAcnGTIO10nxB5YdV9Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 13:01:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANRvAcnGTIO10nxB5YdV9Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:01:45 INFO - Downloaded 57769099 bytes. 13:01:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ANRvAcnGTIO10nxB5YdV9Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 13:01:45 INFO - mkdir: /builds/slave/test-pgo/properties 13:01:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 13:01:45 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 13:01:45 INFO - Contents: 13:01:45 INFO - build_url:https://queue.taskcluster.net/v1/task/ANRvAcnGTIO10nxB5YdV9Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 13:01:46 INFO - Running post-action listener: _resource_record_post_action 13:01:46 INFO - Running post-action listener: set_extra_try_arguments 13:01:46 INFO - ##### 13:01:46 INFO - ##### Running populate-webroot step. 13:01:46 INFO - ##### 13:01:46 INFO - Running pre-action listener: _resource_record_pre_action 13:01:46 INFO - Running main action method: populate_webroot 13:01:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:01:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:01:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:01:46 INFO - '--tppagecycles', 13:01:46 INFO - '7'], 13:01:46 INFO - 'tests': ['tsvgm']}}, 13:01:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:01:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:01:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:01:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:01:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:01:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:01:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:01:46 INFO - 'talos_options': ['--disable-e10s'], 13:01:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:01:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:01:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:01:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:01:46 INFO - 'talos_options': ['--disable-e10s'], 13:01:46 INFO - 'tests': ['damp', 'tps']}, 13:01:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:01:46 INFO - 'tests': ['damp', 'tps']}, 13:01:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:01:46 INFO - 'tests': ['dromaeo_dom']}, 13:01:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:01:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:01:46 INFO - 'tests': ['a11yr', 13:01:46 INFO - 'ts_paint', 13:01:46 INFO - 'tpaint', 13:01:46 INFO - 'sessionrestore', 13:01:46 INFO - 'sessionrestore_no_auto_restore', 13:01:46 INFO - 'tabpaint']}, 13:01:46 INFO - 'other-e10s': {'tests': ['a11yr', 13:01:46 INFO - 'ts_paint', 13:01:46 INFO - 'tpaint', 13:01:46 INFO - 'sessionrestore', 13:01:46 INFO - 'sessionrestore_no_auto_restore', 13:01:46 INFO - 'tabpaint']}, 13:01:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:01:46 INFO - 'ts_paint', 13:01:46 INFO - 'tpaint', 13:01:46 INFO - 'sessionrestore', 13:01:46 INFO - 'sessionrestore_no_auto_restore', 13:01:46 INFO - 'tabpaint']}, 13:01:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:01:46 INFO - 'ts_paint', 13:01:46 INFO - 'tpaint', 13:01:46 INFO - 'sessionrestore', 13:01:46 INFO - 'sessionrestore_no_auto_restore', 13:01:46 INFO - 'tabpaint']}, 13:01:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:01:46 INFO - 'tests': ['a11yr', 13:01:46 INFO - 'ts_paint', 13:01:46 INFO - 'tpaint', 13:01:46 INFO - 'sessionrestore', 13:01:46 INFO - 'sessionrestore_no_auto_restore', 13:01:46 INFO - 'tabpaint']}, 13:01:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:01:46 INFO - 'tests': ['a11yr', 13:01:46 INFO - 'ts_paint', 13:01:46 INFO - 'tpaint', 13:01:46 INFO - 'sessionrestore', 13:01:46 INFO - 'sessionrestore_no_auto_restore', 13:01:46 INFO - 'tabpaint']}, 13:01:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:01:46 INFO - 'tests': ['tsvgx', 13:01:46 INFO - 'tsvgr_opacity', 13:01:46 INFO - 'tart', 13:01:46 INFO - 'tscrollx', 13:01:46 INFO - 'cart']}, 13:01:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:01:46 INFO - 'tsvgr_opacity', 13:01:46 INFO - 'tart', 13:01:46 INFO - 'tscrollx', 13:01:46 INFO - 'cart']}, 13:01:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:01:46 INFO - 'talos_options': ['--disable-e10s'], 13:01:46 INFO - 'tests': ['tp5o']}, 13:01:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:01:46 INFO - 'tests': ['tp5o']}, 13:01:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:01:46 INFO - 'talos_options': ['--disable-e10s', 13:01:46 INFO - '--xperf_path', 13:01:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:01:46 INFO - 'tests': ['tp5n']}, 13:01:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:01:46 INFO - 'talos_options': ['--xperf_path', 13:01:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:01:46 INFO - 'tests': ['tp5n']}}, 13:01:46 INFO - 'talos.zip': {'path': '', 13:01:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:01:46 INFO - Running post-action listener: _resource_record_post_action 13:01:46 INFO - ##### 13:01:46 INFO - ##### Running create-virtualenv step. 13:01:46 INFO - ##### 13:01:46 INFO - Running pre-action listener: _resource_record_pre_action 13:01:46 INFO - Running main action method: create_virtualenv 13:01:46 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 13:01:46 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 13:01:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 13:01:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:01:46 INFO - Using real prefix '/usr' 13:01:46 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 13:01:47 INFO - Installing distribute.............................................................................................................................................................................................done. 13:01:49 INFO - Installing pip.................done. 13:01:49 INFO - Return code: 0 13:01:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 13:01:49 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')]} 13:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:01:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01:49 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')]} 13:01:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:01:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01:49 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 0x7ffbf0a25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcf8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e8b0>, '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 0x105f7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105fc60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1460144889.796129-1899462580', '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 13:01:49 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 13:01:49 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 13:01:49 INFO - Using env: {'DISPLAY': ':0', 13:01:49 INFO - 'HOME': '/home/cltbld', 13:01:49 INFO - 'LANG': 'en_US.UTF-8', 13:01:49 INFO - 'LANGUAGE': 'en_US:en', 13:01:49 INFO - 'LOGNAME': 'cltbld', 13:01:49 INFO - 'MAIL': '/var/mail/cltbld', 13:01:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:01:49 INFO - 'MOZ_NO_REMOTE': '1', 13:01:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:01:49 INFO - 'NO_EM_RESTART': '1', 13:01:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:01:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:01:49 INFO - 'PWD': '/builds/slave/test-pgo', 13:01:49 INFO - 'SHELL': '/bin/bash', 13:01:49 INFO - 'SHLVL': '1', 13:01:49 INFO - 'TERM': 'linux', 13:01:49 INFO - 'TMOUT': '86400', 13:01:49 INFO - 'USER': 'cltbld', 13:01:49 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1460144889.796129-1899462580', 13:01:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:01:49 INFO - '_': '/tools/buildbot/bin/python'} 13:01:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:01:49 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 13:01:49 INFO - Cleaning up... 13:01:49 INFO - Return code: 0 13:01:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 13:01:49 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')]} 13:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:01:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01:49 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')]} 13:01:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:01:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01:49 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 0x7ffbf0a25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcf8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e8b0>, '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 0x105f7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105fc60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1460144889.796129-1899462580', '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 13:01:49 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 13:01:49 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 13:01:49 INFO - Using env: {'DISPLAY': ':0', 13:01:49 INFO - 'HOME': '/home/cltbld', 13:01:49 INFO - 'LANG': 'en_US.UTF-8', 13:01:49 INFO - 'LANGUAGE': 'en_US:en', 13:01:49 INFO - 'LOGNAME': 'cltbld', 13:01:49 INFO - 'MAIL': '/var/mail/cltbld', 13:01:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:01:49 INFO - 'MOZ_NO_REMOTE': '1', 13:01:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:01:49 INFO - 'NO_EM_RESTART': '1', 13:01:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:01:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:01:49 INFO - 'PWD': '/builds/slave/test-pgo', 13:01:49 INFO - 'SHELL': '/bin/bash', 13:01:49 INFO - 'SHLVL': '1', 13:01:49 INFO - 'TERM': 'linux', 13:01:49 INFO - 'TMOUT': '86400', 13:01:49 INFO - 'USER': 'cltbld', 13:01:49 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1460144889.796129-1899462580', 13:01:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:01:49 INFO - '_': '/tools/buildbot/bin/python'} 13:01:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:01:49 INFO - Downloading/unpacking psutil>=0.7.1 13:01:49 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 13:01:49 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 13:01:49 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 13:01:49 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 13:01:49 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 13:01:49 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 13:01:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 13:01:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:01:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:01:52 INFO - Installing collected packages: psutil 13:01:52 INFO - Running setup.py install for psutil 13:01:52 INFO - building 'psutil._psutil_linux' extension 13:01:52 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 13:01:52 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 13:01:52 INFO - building 'psutil._psutil_posix' extension 13:01:52 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 13:01:52 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 13:01:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:01:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:01:52 INFO - Successfully installed psutil 13:01:52 INFO - Cleaning up... 13:01:53 INFO - Return code: 0 13:01:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 13:01: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')]} 13:01:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:01:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01: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')]} 13:01:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:01:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01:53 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 0x7ffbf0a25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcf8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e8b0>, '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 0x105f7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105fc60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1460144889.796129-1899462580', '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 13:01:53 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 13:01:53 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 13:01:53 INFO - Using env: {'DISPLAY': ':0', 13:01:53 INFO - 'HOME': '/home/cltbld', 13:01:53 INFO - 'LANG': 'en_US.UTF-8', 13:01:53 INFO - 'LANGUAGE': 'en_US:en', 13:01:53 INFO - 'LOGNAME': 'cltbld', 13:01:53 INFO - 'MAIL': '/var/mail/cltbld', 13:01:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:01:53 INFO - 'MOZ_NO_REMOTE': '1', 13:01:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:01:53 INFO - 'NO_EM_RESTART': '1', 13:01:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:01:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:01:53 INFO - 'PWD': '/builds/slave/test-pgo', 13:01:53 INFO - 'SHELL': '/bin/bash', 13:01:53 INFO - 'SHLVL': '1', 13:01:53 INFO - 'TERM': 'linux', 13:01:53 INFO - 'TMOUT': '86400', 13:01:53 INFO - 'USER': 'cltbld', 13:01:53 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1460144889.796129-1899462580', 13:01:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:01:53 INFO - '_': '/tools/buildbot/bin/python'} 13:01:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:01:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:01:53 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 13:01:53 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 13:01:53 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 13:01:53 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 13:01:53 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 13:01:53 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 13:01:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:01:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:01:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:01:55 INFO - Installing collected packages: mozsystemmonitor 13:01:55 INFO - Running setup.py install for mozsystemmonitor 13:01:55 INFO - Successfully installed mozsystemmonitor 13:01:55 INFO - Cleaning up... 13:01:55 INFO - Return code: 0 13:01:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 13:01:55 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')]} 13:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:01:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01:55 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')]} 13:01:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:01:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01:55 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 0x7ffbf0a25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcf8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e8b0>, '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 0x105f7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105fc60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1460144889.796129-1899462580', '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 13:01:55 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 13:01:55 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 13:01:55 INFO - Using env: {'DISPLAY': ':0', 13:01:55 INFO - 'HOME': '/home/cltbld', 13:01:55 INFO - 'LANG': 'en_US.UTF-8', 13:01:55 INFO - 'LANGUAGE': 'en_US:en', 13:01:55 INFO - 'LOGNAME': 'cltbld', 13:01:55 INFO - 'MAIL': '/var/mail/cltbld', 13:01:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:01:55 INFO - 'MOZ_NO_REMOTE': '1', 13:01:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:01:55 INFO - 'NO_EM_RESTART': '1', 13:01:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:01:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:01:55 INFO - 'PWD': '/builds/slave/test-pgo', 13:01:55 INFO - 'SHELL': '/bin/bash', 13:01:55 INFO - 'SHLVL': '1', 13:01:55 INFO - 'TERM': 'linux', 13:01:55 INFO - 'TMOUT': '86400', 13:01:55 INFO - 'USER': 'cltbld', 13:01:55 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1460144889.796129-1899462580', 13:01:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:01:55 INFO - '_': '/tools/buildbot/bin/python'} 13:01:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:01:55 INFO - Downloading/unpacking blobuploader==1.2.4 13:01:55 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 13:01:55 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 13:01:55 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 13:01:55 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 13:01:55 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 13:01:55 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 13:01:57 INFO - Downloading blobuploader-1.2.4.tar.gz 13:01:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:01:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:01:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:01:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:01:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:01:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:01:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:01:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:01:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 13:01:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:01:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:01:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:01:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:01:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:01:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:01:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:01:58 INFO - Downloading docopt-0.6.1.tar.gz 13:01:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 13:01:58 INFO - Installing collected packages: blobuploader, requests, docopt 13:01:58 INFO - Running setup.py install for blobuploader 13:01:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:01:58 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 13:01:58 INFO - Running setup.py install for requests 13:01:58 INFO - Running setup.py install for docopt 13:01:58 INFO - Successfully installed blobuploader requests docopt 13:01:58 INFO - Cleaning up... 13:01:58 INFO - Return code: 0 13:01:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:01: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')]} 13:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:01:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01: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')]} 13:01:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:01:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01:58 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 0x7ffbf0a25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcf8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e8b0>, '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 0x105f7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105fc60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1460144889.796129-1899462580', '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 13:01:58 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 13:01:58 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 13:01:58 INFO - Using env: {'DISPLAY': ':0', 13:01:58 INFO - 'HOME': '/home/cltbld', 13:01:58 INFO - 'LANG': 'en_US.UTF-8', 13:01:58 INFO - 'LANGUAGE': 'en_US:en', 13:01:58 INFO - 'LOGNAME': 'cltbld', 13:01:58 INFO - 'MAIL': '/var/mail/cltbld', 13:01:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:01:58 INFO - 'MOZ_NO_REMOTE': '1', 13:01:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:01:58 INFO - 'NO_EM_RESTART': '1', 13:01:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:01:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:01:58 INFO - 'PWD': '/builds/slave/test-pgo', 13:01:58 INFO - 'SHELL': '/bin/bash', 13:01:58 INFO - 'SHLVL': '1', 13:01:58 INFO - 'TERM': 'linux', 13:01:58 INFO - 'TMOUT': '86400', 13:01:58 INFO - 'USER': 'cltbld', 13:01:58 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1460144889.796129-1899462580', 13:01:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:01:58 INFO - '_': '/tools/buildbot/bin/python'} 13:01:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:01:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:01:58 INFO - Running setup.py (path:/tmp/pip-_w1sUw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:01:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:01:59 INFO - Running setup.py (path:/tmp/pip-UCaEas-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:01:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:01:59 INFO - Running setup.py (path:/tmp/pip-06cVDD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:01:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:01:59 INFO - Running setup.py (path:/tmp/pip-yrB_TD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:01:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:01:59 INFO - Running setup.py (path:/tmp/pip-tNbeda-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:01:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:01:59 INFO - Running setup.py (path:/tmp/pip-GDkkxG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:01:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:01:59 INFO - Running setup.py (path:/tmp/pip-qj7rBt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:01:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:01:59 INFO - Running setup.py (path:/tmp/pip-z_WqpR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:01:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:01:59 INFO - Running setup.py (path:/tmp/pip-SGWbRr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:01:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:01:59 INFO - Running setup.py (path:/tmp/pip-Bc9KAP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:01:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:01:59 INFO - Running setup.py (path:/tmp/pip-z5pz9A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:01:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:01:59 INFO - Running setup.py (path:/tmp/pip-9r3NIs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:01:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:01:59 INFO - Running setup.py (path:/tmp/pip-8iMbz4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:01:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:01:59 INFO - Running setup.py (path:/tmp/pip-5U9baK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:02:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:02:00 INFO - Running setup.py (path:/tmp/pip-z1LxkF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:02:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:02:00 INFO - Running setup.py (path:/tmp/pip-4HhdNt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:02:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:02:00 INFO - Running setup.py (path:/tmp/pip-hb3ELn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:02:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:02:00 INFO - Running setup.py install for manifestparser 13:02:00 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 13:02:00 INFO - Running setup.py install for mozcrash 13:02:00 INFO - Running setup.py install for mozdebug 13:02:00 INFO - Running setup.py install for mozdevice 13:02:00 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 13:02:00 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 13:02:00 INFO - Running setup.py install for mozfile 13:02:00 INFO - Running setup.py install for mozhttpd 13:02:00 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 13:02:00 INFO - Running setup.py install for mozinfo 13:02:00 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 13:02:00 INFO - Running setup.py install for mozInstall 13:02:01 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 13:02:01 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 13:02:01 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 13:02:01 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 13:02:01 INFO - Running setup.py install for mozleak 13:02:01 INFO - Running setup.py install for mozlog 13:02:01 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 13:02:01 INFO - Running setup.py install for moznetwork 13:02:01 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 13:02:01 INFO - Running setup.py install for mozprocess 13:02:01 INFO - Running setup.py install for mozprofile 13:02:01 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 13:02:01 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 13:02:01 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 13:02:01 INFO - Running setup.py install for mozrunner 13:02:01 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 13:02:01 INFO - Running setup.py install for mozscreenshot 13:02:01 INFO - Running setup.py install for moztest 13:02:01 INFO - Running setup.py install for mozversion 13:02:01 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 13:02:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:02:01 INFO - Cleaning up... 13:02:02 INFO - Return code: 0 13:02:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:02:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:02:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:02 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 0x7ffbf0a25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcf8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e8b0>, '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 0x105f7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105fc60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1460144889.796129-1899462580', '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 13:02:02 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 13:02:02 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 13:02:02 INFO - Using env: {'DISPLAY': ':0', 13:02:02 INFO - 'HOME': '/home/cltbld', 13:02:02 INFO - 'LANG': 'en_US.UTF-8', 13:02:02 INFO - 'LANGUAGE': 'en_US:en', 13:02:02 INFO - 'LOGNAME': 'cltbld', 13:02:02 INFO - 'MAIL': '/var/mail/cltbld', 13:02:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:02 INFO - 'MOZ_NO_REMOTE': '1', 13:02:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:02:02 INFO - 'NO_EM_RESTART': '1', 13:02:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:02:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:02:02 INFO - 'PWD': '/builds/slave/test-pgo', 13:02:02 INFO - 'SHELL': '/bin/bash', 13:02:02 INFO - 'SHLVL': '1', 13:02:02 INFO - 'TERM': 'linux', 13:02:02 INFO - 'TMOUT': '86400', 13:02:02 INFO - 'USER': 'cltbld', 13:02:02 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1460144889.796129-1899462580', 13:02:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:02 INFO - '_': '/tools/buildbot/bin/python'} 13:02:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:02:02 INFO - Running setup.py (path:/tmp/pip-EkKRzE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:02:02 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)) 13:02:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:02:02 INFO - Running setup.py (path:/tmp/pip-HZZ26X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:02:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 13:02:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:02:02 INFO - Running setup.py (path:/tmp/pip-Ew2WWM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:02:02 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)) 13:02:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:02:02 INFO - Running setup.py (path:/tmp/pip-51U6cg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:02:02 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)) 13:02:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:02:02 INFO - Running setup.py (path:/tmp/pip-Q5t2ik-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:02:02 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)) 13:02:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:02:02 INFO - Running setup.py (path:/tmp/pip-xoDxiy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:02:02 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)) 13:02:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:02:02 INFO - Running setup.py (path:/tmp/pip-btBF7E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:02:02 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)) 13:02:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:02:02 INFO - Running setup.py (path:/tmp/pip-fQjxEs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:02:02 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)) 13:02:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:02:02 INFO - Running setup.py (path:/tmp/pip-HA_SLN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:02:02 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)) 13:02:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:02:02 INFO - Running setup.py (path:/tmp/pip-pXFYzk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:02:02 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)) 13:02:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:02:02 INFO - Running setup.py (path:/tmp/pip-gIIvuZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:02:03 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)) 13:02:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:02:03 INFO - Running setup.py (path:/tmp/pip-ToVxsm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:02:03 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)) 13:02:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:02:03 INFO - Running setup.py (path:/tmp/pip-gCadZ6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:02:03 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)) 13:02:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:02:03 INFO - Running setup.py (path:/tmp/pip-aIoA9x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:02:03 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)) 13:02:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:02:03 INFO - Running setup.py (path:/tmp/pip-_IeuvY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:02:03 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)) 13:02:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:02:03 INFO - Running setup.py (path:/tmp/pip-TCWaUt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:02:03 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)) 13:02:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:02:03 INFO - Running setup.py (path:/tmp/pip-93hzLF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:02:03 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)) 13:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 13:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 13:02:03 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)) 13:02:03 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)) 13:02:03 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)) 13:02:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 13:02: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 13:02: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 13:02: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 13:02: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 13:02: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 13:02: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 13:02:05 INFO - Downloading blessings-1.6.tar.gz 13:02:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 13:02:05 INFO - Installing collected packages: blessings 13:02:05 INFO - Running setup.py install for blessings 13:02:05 INFO - Successfully installed blessings 13:02:05 INFO - Cleaning up... 13:02:05 INFO - Return code: 0 13:02:05 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 13:02:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:02:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:02:05 INFO - Reading from file tmpfile_stdout 13:02:05 INFO - Current package versions: 13:02:05 INFO - argparse == 1.2.1 13:02:05 INFO - blessings == 1.6 13:02:05 INFO - blobuploader == 1.2.4 13:02:05 INFO - docopt == 0.6.1 13:02:05 INFO - manifestparser == 1.1 13:02:05 INFO - mozInstall == 1.12 13:02:05 INFO - mozcrash == 0.17 13:02:05 INFO - mozdebug == 0.1 13:02:05 INFO - mozdevice == 0.48 13:02:05 INFO - mozfile == 1.2 13:02:05 INFO - mozhttpd == 0.7 13:02:05 INFO - mozinfo == 0.9 13:02:05 INFO - mozleak == 0.1 13:02:05 INFO - mozlog == 3.1 13:02:05 INFO - moznetwork == 0.27 13:02:05 INFO - mozprocess == 0.22 13:02:05 INFO - mozprofile == 0.28 13:02:05 INFO - mozrunner == 6.11 13:02:05 INFO - mozscreenshot == 0.1 13:02:05 INFO - mozsystemmonitor == 0.0 13:02:05 INFO - moztest == 0.7 13:02:05 INFO - mozversion == 1.4 13:02:05 INFO - psutil == 3.1.1 13:02:05 INFO - requests == 1.2.3 13:02:05 INFO - wsgiref == 0.1.2 13:02:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:02:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:02:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:05 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 0x7ffbf0a25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcf8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e8b0>, '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 0x105f7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105fc60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1460144889.796129-1899462580', '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 13:02:05 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 13:02:05 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 13:02:05 INFO - Using env: {'DISPLAY': ':0', 13:02:05 INFO - 'HOME': '/home/cltbld', 13:02:05 INFO - 'LANG': 'en_US.UTF-8', 13:02:05 INFO - 'LANGUAGE': 'en_US:en', 13:02:05 INFO - 'LOGNAME': 'cltbld', 13:02:05 INFO - 'MAIL': '/var/mail/cltbld', 13:02:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:05 INFO - 'MOZ_NO_REMOTE': '1', 13:02:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:02:05 INFO - 'NO_EM_RESTART': '1', 13:02:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:02:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:02:05 INFO - 'PWD': '/builds/slave/test-pgo', 13:02:05 INFO - 'SHELL': '/bin/bash', 13:02:05 INFO - 'SHLVL': '1', 13:02:05 INFO - 'TERM': 'linux', 13:02:05 INFO - 'TMOUT': '86400', 13:02:05 INFO - 'USER': 'cltbld', 13:02:05 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1460144889.796129-1899462580', 13:02:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:05 INFO - '_': '/tools/buildbot/bin/python'} 13:02:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:05 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)) 13:02:05 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)) 13:02:05 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)) 13:02:05 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)) 13:02:05 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)) 13:02:05 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)) 13:02:05 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)) 13:02:05 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)) 13:02:06 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)) 13:02:06 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)) 13:02:06 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)) 13:02:06 INFO - Cleaning up... 13:02:06 INFO - Return code: 0 13:02:06 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 13:02: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')]} 13:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02: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')]} 13:02:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:06 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 0x7ffbf0a25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcf8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e8b0>, '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 0x105f7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105fc60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1460144889.796129-1899462580', '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 13:02:06 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 13:02:06 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 13:02:06 INFO - Using env: {'DISPLAY': ':0', 13:02:06 INFO - 'HOME': '/home/cltbld', 13:02:06 INFO - 'LANG': 'en_US.UTF-8', 13:02:06 INFO - 'LANGUAGE': 'en_US:en', 13:02:06 INFO - 'LOGNAME': 'cltbld', 13:02:06 INFO - 'MAIL': '/var/mail/cltbld', 13:02:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:06 INFO - 'MOZ_NO_REMOTE': '1', 13:02:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:02:06 INFO - 'NO_EM_RESTART': '1', 13:02:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:02:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:02:06 INFO - 'PWD': '/builds/slave/test-pgo', 13:02:06 INFO - 'SHELL': '/bin/bash', 13:02:06 INFO - 'SHLVL': '1', 13:02:06 INFO - 'TERM': 'linux', 13:02:06 INFO - 'TMOUT': '86400', 13:02:06 INFO - 'USER': 'cltbld', 13:02:06 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1460144889.796129-1899462580', 13:02:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:06 INFO - '_': '/tools/buildbot/bin/python'} 13:02:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:06 INFO - Downloading/unpacking jsonschema 13:02: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 13:02: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 13:02: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 13:02: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 13:02: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 13:02: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 13:02:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:02:08 INFO - Downloading/unpacking functools32 (from jsonschema) 13:02:08 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 13:02:08 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 13:02:08 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 13:02:08 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 13:02:08 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 13:02:08 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 13:02:08 INFO - Downloading functools32-3.2.3-2.tar.gz 13:02:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 13:02:08 INFO - warning: no files found matching '*.txt' 13:02:08 INFO - no previously-included directories found matching 'build' 13:02:08 INFO - no previously-included directories found matching 'dist' 13:02:08 INFO - no previously-included directories found matching '.git*' 13:02:08 INFO - Installing collected packages: jsonschema, functools32 13:02:08 INFO - Running setup.py install for functools32 13:02:08 INFO - warning: no files found matching '*.txt' 13:02:08 INFO - no previously-included directories found matching 'build' 13:02:08 INFO - no previously-included directories found matching 'dist' 13:02:08 INFO - no previously-included directories found matching '.git*' 13:02:08 INFO - Successfully installed jsonschema functools32 13:02:08 INFO - Cleaning up... 13:02:08 INFO - Return code: 0 13:02:08 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 13:02:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:02:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:08 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 0x7ffbf0a25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcf8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e8b0>, '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 0x105f7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105fc60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1460144889.796129-1899462580', '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 13:02:08 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 13:02:08 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 13:02:08 INFO - Using env: {'DISPLAY': ':0', 13:02:08 INFO - 'HOME': '/home/cltbld', 13:02:08 INFO - 'LANG': 'en_US.UTF-8', 13:02:08 INFO - 'LANGUAGE': 'en_US:en', 13:02:08 INFO - 'LOGNAME': 'cltbld', 13:02:08 INFO - 'MAIL': '/var/mail/cltbld', 13:02:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:08 INFO - 'MOZ_NO_REMOTE': '1', 13:02:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:02:08 INFO - 'NO_EM_RESTART': '1', 13:02:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:02:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:02:08 INFO - 'PWD': '/builds/slave/test-pgo', 13:02:08 INFO - 'SHELL': '/bin/bash', 13:02:08 INFO - 'SHLVL': '1', 13:02:08 INFO - 'TERM': 'linux', 13:02:08 INFO - 'TMOUT': '86400', 13:02:08 INFO - 'USER': 'cltbld', 13:02:08 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1460144889.796129-1899462580', 13:02:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:08 INFO - '_': '/tools/buildbot/bin/python'} 13:02:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:08 INFO - Downloading/unpacking flake8 13:02:08 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 13:02:08 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 13:02:08 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 13:02:08 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 13:02:08 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 13:02:08 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 13:02:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:02:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:02:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:02:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:02:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:02:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:02:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:02:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:02:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:02:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:02:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:02:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:02:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:02: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 13:02: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 13:02: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 13:02: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 13:02: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 13:02: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 13:02:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 13:02:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:02:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:02:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:02:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:02:11 INFO - no previously-included directories found matching 'docs/_build' 13:02:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:02:11 INFO - Running setup.py install for pep8 13:02:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:02:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:02:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:02:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:02:11 INFO - no previously-included directories found matching 'docs/_build' 13:02:11 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 13:02:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:02:11 INFO - Cleaning up... 13:02:11 INFO - Return code: 0 13:02:11 INFO - Running post-action listener: _resource_record_post_action 13:02:11 INFO - Running post-action listener: _start_resource_monitoring 13:02:11 INFO - Starting resource monitoring. 13:02:11 INFO - ##### 13:02:11 INFO - ##### Running install step. 13:02:11 INFO - ##### 13:02:11 INFO - Running pre-action listener: _resource_record_pre_action 13:02:11 INFO - Running main action method: install 13:02:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:02:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:02:11 INFO - Reading from file tmpfile_stdout 13:02:11 INFO - Detecting whether we're running mozinstall >=1.0... 13:02:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 13:02:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 13:02:11 INFO - Reading from file tmpfile_stdout 13:02:11 INFO - Output received: 13:02:11 INFO - Usage: mozinstall [options] installer 13:02:11 INFO - Options: 13:02:11 INFO - -h, --help show this help message and exit 13:02:11 INFO - -d DEST, --destination=DEST 13:02:11 INFO - Directory to install application into. [default: 13:02:11 INFO - "/builds/slave/test-pgo"] 13:02:11 INFO - --app=APP Application being installed. [default: firefox] 13:02:11 INFO - mkdir: /builds/slave/test-pgo/build/application 13:02:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 13:02:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 13:02:28 INFO - Reading from file tmpfile_stdout 13:02:28 INFO - Output received: 13:02:28 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 13:02:28 INFO - Running post-action listener: _resource_record_post_action 13:02:28 INFO - ##### 13:02:28 INFO - ##### Running run-tests step. 13:02:28 INFO - ##### 13:02:28 INFO - Running pre-action listener: _resource_record_pre_action 13:02:28 INFO - Running main action method: run_tests 13:02:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 13:02:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 13:02:28 INFO - Python 2.7.3 13:02:28 INFO - Return code: 0 13:02:28 INFO - grabbing minidump binary from tooltool 13:02:28 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')]} 13:02:28 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 0x105e8b0>, '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 0x105f7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105fc60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 13:02:28 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 13:02:28 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 13:02:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:02:28 INFO - Return code: 0 13:02:28 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 13:02:28 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 13:02:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 13:02:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 13:02:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 13:02:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 13:02:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 13:02:29 INFO - Return code: 0 13:02:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ANRvAcnGTIO10nxB5YdV9Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 13:02:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ANRvAcnGTIO10nxB5YdV9Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 13:02:29 INFO - Using env: {'DISPLAY': ':0', 13:02:29 INFO - 'HOME': '/home/cltbld', 13:02:29 INFO - 'LANG': 'en_US.UTF-8', 13:02:29 INFO - 'LANGUAGE': 'en_US:en', 13:02:29 INFO - 'LOGNAME': 'cltbld', 13:02:29 INFO - 'MAIL': '/var/mail/cltbld', 13:02:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:02:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 13:02:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:29 INFO - 'MOZ_NO_REMOTE': '1', 13:02:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:02:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:02:29 INFO - 'NO_EM_RESTART': '1', 13:02:29 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:02:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:02:29 INFO - 'PWD': '/builds/slave/test-pgo', 13:02:29 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 13:02:29 INFO - 'SHELL': '/bin/bash', 13:02:29 INFO - 'SHLVL': '1', 13:02:29 INFO - 'TERM': 'linux', 13:02:29 INFO - 'TMOUT': '86400', 13:02:29 INFO - 'USER': 'cltbld', 13:02:29 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1460144889.796129-1899462580', 13:02:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:29 INFO - '_': '/tools/buildbot/bin/python'} 13:02:29 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ANRvAcnGTIO10nxB5YdV9Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:02:29 INFO - mozversion application_buildid: 20160408103057 13:02:29 INFO - mozversion application_changeset: dbc96a62c1da23c6e31e6194617386767851d45a 13:02:29 INFO - mozversion application_display_name: Nightly 13:02:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:02:29 INFO - mozversion application_name: Firefox 13:02:29 INFO - mozversion application_remotingname: firefox 13:02:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 13:02:29 INFO - mozversion application_vendor: Mozilla 13:02:29 INFO - mozversion application_version: 48.0a1 13:02:29 INFO - mozversion platform_buildid: 20160408103057 13:02:29 INFO - mozversion platform_changeset: dbc96a62c1da23c6e31e6194617386767851d45a 13:02:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 13:02:29 INFO - mozversion platform_version: 48.0a1 13:02:29 INFO - using testdate: 1460145749 13:02:29 INFO - actual date: 1460145749 13:02:29 INFO - starting webserver on 'localhost:60750' 13:02:29 INFO - SUITE-START | Running 2 tests 13:02:29 INFO - TEST-START | dromaeo_css 13:02:29 INFO - operating with platform_type : linux_ 13:02:29 INFO - Initialising browser for dromaeo_css test... 13:02:29 INFO - TEST-INFO | started process 15382 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptiMq1_/profile http://localhost:60750/getInfo.html) 13:02:33 INFO - PROCESS | 15382 | __metrics Screen width/height:1600/1200 13:02:33 INFO - PROCESS | 15382 | colorDepth:24 13:02:33 INFO - PROCESS | 15382 | Browser inner width/height: 1024/697 13:02:33 INFO - PROCESS | 15382 | __metrics 13:02:34 ERROR - PROCESS | 15382 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:02:35 INFO - TEST-INFO | 15382: exit 0 13:02:35 INFO - Browser initialized. 13:02:35 INFO - Running cycle 1/1 for dromaeo_css test... 13:02:35 INFO - TEST-INFO | started process 15464 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptiMq1_/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:02:46 INFO - PROCESS | 15464 | RSS: Main: 152473600 13:02:46 INFO - PROCESS | 15464 | 13:03:37 INFO - PROCESS | 15464 | 1460145817882 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] 13:05:45 INFO - PROCESS | 15464 | Cycle 1(1): loaded http://localhost:60750/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60750/tests/dromaeo/cssquery-ext.html) 13:05:46 INFO - PROCESS | 15464 | RSS: Main: 247795712 13:05:46 INFO - PROCESS | 15464 | 13:08:48 INFO - PROCESS | 15464 | Cycle 1(1): loaded http://localhost:60750/tests/dromaeo/cssquery-ext.html (next: http://localhost:60750/tests/dromaeo/cssquery-jquery.html) 13:08:49 INFO - PROCESS | 15464 | RSS: Main: 236199936 13:08:49 INFO - PROCESS | 15464 | 13:11:51 INFO - PROCESS | 15464 | Cycle 1(1): loaded http://localhost:60750/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60750/tests/dromaeo/cssquery-mootools.html) 13:11:51 INFO - PROCESS | 15464 | RSS: Main: 225906688 13:11:51 INFO - PROCESS | 15464 | 13:14:53 INFO - PROCESS | 15464 | Cycle 1(1): loaded http://localhost:60750/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60750/tests/dromaeo/cssquery-prototype.html) 13:14:54 INFO - PROCESS | 15464 | RSS: Main: 218812416 13:14:54 INFO - PROCESS | 15464 | 13:17:56 INFO - PROCESS | 15464 | Cycle 1(1): loaded http://localhost:60750/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60750/tests/dromaeo/cssquery-yui.html) 13:17:57 INFO - PROCESS | 15464 | RSS: Main: 209817600 13:17:57 INFO - PROCESS | 15464 | 13:20:59 INFO - PROCESS | 15464 | Cycle 1(1): loaded http://localhost:60750/tests/dromaeo/cssquery-yui.html (next: http://localhost:60750/tests/dromaeo/cssquery-dojo.html) 13:21:00 INFO - PROCESS | 15464 | RSS: Main: 268435456 13:21:00 INFO - PROCESS | 15464 | 13:21:00 INFO - PROCESS | 15464 | __start_tp_report 13:21:00 INFO - PROCESS | 15464 | _x_x_mozilla_page_load 13:21:00 INFO - PROCESS | 15464 | _x_x_mozilla_page_load_details 13:21:00 INFO - PROCESS | 15464 | |i|pagename|runs| 13:21:00 INFO - PROCESS | 15464 | |0;dojo.html;3128.389963957028;3164.129864287322;3167.4773662345715;3193.441147799135;3215.807051576905;5231.816886408977;5352.304200453946;5359.196120581914;5369.167778994252;5450.04624190766;5312.6281160318795;5326.174442961337;5353.625246232766;5383.084875571152;5409.864753381157;4779.474257831635;4793.32893394925;4815.157347464197;4830.3237546743485;4906.558409743122;4828.806847726087;4873.34209881665;4874.415070191564;4881.316615673791;4924.433690125627;4733.526647335256;4781.091592597395;4792.496787837262;4807.03859228154;4857.465678775332;4866.537678920532;4879.072976134523;4893.681910675795;4900.558949694509;4932.260160975882;4854.854354369375;4878.219484882402;4879.463259041502;4879.536444037846;4888.584470320027;5134.537891589737;5227.634065615409;5278.947210527922;5340.813071542516;5362.705051222181;5674.546036317085;5677;5701.714914254312;5704;5705.372409035002;5617.943820561783;5772;5773.307203135609;5774.393688662714;5775.509081728058;5298.311219541473;5350.545203657655;5354.5180933715765;5392.272043274186;5394.298741163623;5883.058710606282;5883.235179426732;5883.499902508249;5892.381299963527;5893.057110862242;5517.089680202802;5572.888542229132;5655;5655.208270842086;5658.009848276535;5723.77104915807;5724.4561766632105;5726.141078838207;5740.339860915965;5779.88440231193;5691.573132015115;5696.629719068247;5697.772089116472;5702.971485142548;5703.914441283384;5589.35722391922;5617.41017193197;5692.37383887772;5694.288213973254;5739.7417116229035;4341.826326946887;4359.084592235666;4364.170807546556;4393.494748104009;4402.405675233803;3886.96113038866;3902.083010492532;3907.9218415631526;3931.1351502669368;3931.783751893616;5255.343082114736;5299.417064122943;5316.787328506816;5407.215953686693;5413.945860541423;5682.659040457585;5691.9715401423555;5697.772089116389;5703.572232082611;5744.712764361765;5328.3605967284175;5371.033214021436;5372.059889519319;5372.140457526777;5373.516383525502;4836.637252206098;4865.270209468608;4948.455669876311;4953.8266160684925;4956.553910148104;5831.125331200269;5831.650100993954;5835.4748072673665;5836;5836.095405212199;5648.096304591246;5650.660960342392;5652.265205523256;5663.405342439067;5669.036263835075;5831.4168583141345;5869.325027621878;5875.50058245054;5917.970410148094;5932.199153114447;5626.887462250814;5662.915056274242;5665.546756259407;5670.688112153706;5671.347795003628;5606.159076138611;5691.174779657009;5761.135829625589;5765.884682306414;5768.53851691872;5552.52803511706;5594.38461769197;5595.468430499096;5632.493075623213;5647.604667673223;5577.079781836114;5589.385167631639;5593.105103183634;5594.692291923983;5594.86012849682;5412.648177868426;5444.128939369682;5489.725513724377;5518;5562.888742225214;5611.5230205433;5654.547636189012;5657.858553536194;5663.263775709296;5699.487046165865;5531.612787104864;5534.280543529316;5535.529479994246;5535.695536745357;5565.833025009256 13:21:00 INFO - PROCESS | 15464 | |1;ext.html;615.9322474527801;645.3514218210697;661.6658587413359;662.9138212032436;672.8183390484569;30570;37231.255374892484;38940.22119557607;38958.22083558327;39013.21973560527;41279.17441651173;41848;41989.79005104978;42071.15857682844;42180.36729449061;7749.457537972344;8391.706290279826;8550.486970781772;8563.743087707378;8567.35744819138;7843.137254901984;7947.602619869012;7948.324392426651;10211.234157438184;10590.09984151348;10197.541110650038;10279.897201028007;10293.794124117514;10294.382337059764;10304.536295866666;10064.245181611372;10229.795404091876;10235.897641023643;10238.795224095551;10243.28297019209;7865.7246996355425;10142.442165680885;10492.895071049268;10493.685189444328;10502.632407865687;35547.82226088879;36189.095272618135;36207.094822629646;36259.81870090659;36268;3467.7745946513396;3516.6659167379057;3589.4795254688183;3624.981875090634;3762.5108735864164;28895.823188607315;29017.419651607062;29103.70896291031;32349.029529114163;33307.33385332304;4285.46431696038;4301.78491075445;4381.474223093217;4384.517703052662;4387.1445068211715;284800.75996200106;285406;285412;285432;286036.9999999979;35183.64816351804;56852.43147568554;57255.42744572584;57270.713646431504;57304.42695573074;34758.47862282068;35043.29913401769;35051;35055.4741678875;35097;14535.27323633814;14811.111333320036;14812.92593537047;14820.110793352218;14840.777388339184;11007.449627518592;11009.339439633648;11013.614523491638;11021.504032318566;11076.723081923017;8524;8694.565271736388;8711.651533938699;8719.60761765722;8773.692920747742;3381.7801842880135;3430.9828450857585;3440.3119376124373;3443.517907492903;3459.08334291413;1051.7002654243504;1062;1074.2319241742036;1110.7278716714457;1162.616336608917;31693;31986.360272794413;32148.83925580357;32315.35369292648;32733;1129.8474705914762;1159.4260840883817;1214.1136970011764;1216.7688139253514;1301.0242318261303;16411.753823692656;17161.227744751515;17179.484615461555;17237.56906077333;17255.137243137793;422022;424463;426312.68436578044;426938;427749;54386.184207236925;54555.18167227495;55002.724986374815;55122.44877551253;55142.72428637831;1250.7748605251143;1344.1464669934467;1358.409092044944;1374.6906945937285;1436.8347640021323;29830.70169298279;31187.84406077955;31486.212844679067;31884;32016.839915800272;45967;46330.536694632625;48219.75890120527;48356.27465587949;48401.5159848397;362290;369021;370540;371222;371284;37179.44230836486;43815;47700.761496192295;48067.27899081587;48762.5123748758;48211.27683084827;48778;49377.75311123421;49650;49909.500904990484;39534.604653954244;40538.39192412057;41094.1781164369;41237.58762412457;41542;41528.37707434451;41558;41706;41767.58232417637;43065.78467107644;40719.389209161294;41406.171876562905;42264.1547169061;42780.358294626225;42832.78583607187;34369.656303437645;36402.146004215276;36584.26831463409;36706.26587468182;36913.815430922674;27880.721192787812;28303.858480707466;28333;28359.57460638051;28403.857980709963 13:21:00 INFO - PROCESS | 15464 | |2;jquery.html;398.7547658190213;402.33212866641384;403.67907513526745;409.73981521733697;416.42949159651283;14608.634784130401;17486.562835929093;18095.366662166827;18109.547261318457;18512.25950961963;16458.09480478573;16830.99014059154;17756;18792.71810922834;18815.341463048797;5297.258383826267;5588.916166257489;5588.916166257489;5653.067243904751;5919.763209471616;3843.2889915365745;5543.196236545698;5568.248286481334;5613.522850557708;5829.533637309005;5811.157382179603;5812.041013232812;5829.941700582982;5830.854228644275;5836.15375770513;5684.658920464785;5775.537956963432;5783.797567085174;5786.681732504731;5790.507806836403;5526.06056970312;5635.464630860061;5642.576806739511;5643.774249030034;5646.717664116778;12524.373781310898;13276.800847987288;13278.933605332008;13287.933560332136;13289;2215.7784221577876;2347.213683416058;2405.6511805788064;2578.329634295078;2784.317842128671;9725.65960191397;9817.950910245474;9911.306208565404;10023.198144148451;10340.689779306633;1840.6410749903773;1919.193938545814;1935.535471486833;1953.0625299856006;1981.1580078466739;63696.68151659212;67865.32134678689;69758;70425;76210.61894690491;10378;10587.205959553065;10762.78474430507;10777.137828973664;10829.83755243672;13459.730805383837;13955.441782328797;15187.620309492351;15259.465918692793;15266.465673701367;7527.887081693779;7898.881516777253;7984.960075199587;8062.475939063942;8203.138670439517;7478.663460144307;7491.325780679765;7606.80982975419;7828.217178282126;7848.0974687910475;4458.152950939311;4562.8631141065825;4688.531146885352;4776.59398951093;4859.076775412731;1917.3289348727833;1950.9219631214592;1961.7057441383906;1981.0787983587702;1981.9009049547753;918.554501066982;980.0934135924241;994.7811481474064;1021.6219998600566;1061.2783307350921;18784.436466906016;18832.81167188338;19295.614087718168;19398.70901936472;19404.477417935577;956.2015716876347;992.6823416506793;1000.564754331868;1002.2533212756397;1008.7326858382535;9452.480113593681;10123.088921997056;10163.390196588229;10169.491525423698;10265.589376425009;492809;503124;507960;515293;516757;89403;91584;92933;92995;93059.53470232605;1054.7415883108688;1076.3326737422692;1102.3385968418884;1102.459794700607;1114.5653195253858;15463.226838657796;15717.921410393332;15776.211189440712;15882.364705411654;15895.841041589436;26219.378062193628;32775.67224327726;33686.663133368354;34330.48504272388;35308.29383412266;47817.28274075822;48018.75990620025;48041.03917921552;48364.758176208896;48616.75691621519;7182.317679820409;7717.768466946;8388.203120703523;8438.324934005388;8662.913370866463;10858.619948301772;12771.744565108831;13245.668858278621;13479.595612131652;13498.52755153565;11482.13883958723;11697.473613687574;11827.349495777815;11834.230774999598;11988.64034078979;11346.319220846775;11645.126615504041;11708.121890858049;11805.527778888749;11960.521579137085;11469.139814513777;11700.824487632523;11822;12091.81862272049;12189.451474683838;7881.487703299267;8050.872877796996;8054.073781515201;8131.2681858633005;8150.877736834071;8833.602487888189;10844.295120817122;10911.089460141335;11539.596114135966;11930.701732456759 13:21:00 INFO - PROCESS | 15464 | |3;mootools.html;1361.6731984323765;1529.3194528434847;1546.2655238761588;1731.2988239762892;1869.093489657515;8109.351251899849;8371.455855369404;8376.958115209416;8381.958090209548;8457.53483558404;8173.754787356389;8315.584220788967;8324;8339.74980750577;8345.332373410129;1989.1347263940231;2277.453411181321;2310.607196776544;2332.475193081556;2367.775061369176;2200.6038912995655;2213.2917466410754;2214.6345852934246;2215.601191785478;2218.8779617121054;2145.1205005947563;2170.2295685031822;2173.174193806359;2176.3035828534876;2176.3579743975565;1898.8670793044491;2224.5328481019005;2279.726432828063;2286.7713228677167;2288.1762565476415;2202.174184680745;2204.8566843155304;2210.9557808843733;2211.9447013824624;2267.319804058776;8176.6320515576945;8191.385646076568;8264.256216940505;8264.710735124241;8283.37874659403;5015.172496538067;5208.088584497697;5209.6874187548865;5229.2417599448245;5229.869253268661;3578.3916734155255;3589.174489867345;3593.2633810069133;3644.1982763791925;3671.320805650963;1125.4204084896285;1146.358039497884;1159.6636975277245;1179.6637958181877;1197.323512215604;11643.883561164364;11653.766924661459;11660.708482287926;11665.766684666343;11667.824982625183;4366.083122544238;4477.552244775497;4606.815727370935;4639.466461356988;4642.86071417858;9746.269029822792;9786.1192492676;9788.608455661837;9791;9803.068708472683;4704.200285951328;5156.63903526757;5198.506141916512;5204.323437953042;5204.713740744295;4367.541408152162;4397.032652816375;4398;4562.338460923148;4644.512326205768;3709.536307961505;3790.3935370340614;3813.523309586302;3836.5204349456317;3998.140399813996;1254.7427777305631;1262.7790136726037;1263.6588121207224;1265.981010284828;1266.7262264235535;1413.971720565583;1417.7093695792337;1441.128117488904;1451.7314296855116;1461.116024804999;7928.088269848926;7942.126366099725;7942.920570794334;7952.284294413531;8010.118886922434;468.641489260709;480.274785074533;482.2115840600573;483.5309749543008;486.0521982134851;6163.322034576193;6200.627962322275;6201;6243.032329988859;6246.219222597176;9836.311458198;10257.692269231935;10354.326968747007;10376.16990640762;10393.16854651626;10091.798164036678;10242.436665983294;10259.076683098558;10267.383956962607;10292.691219263434;7899.960500197462;7916.050073991158;7924.286814186866;8005.319547838382;8015.278624923785;7656.425768067528;7919.0893047298;7925.841483170419;7950.4832185907735;7951.880721789294;9533.30773565235;9578.664746733832;9601.567929443052;9613.058949411612;9720.562574684298;9648.083432073941;9716.562754675915;9834.213262938805;9834.75413114678;9979.351342162736;6850.9314906850295;7234.240404757636;7347.963260183665;7418;7486.850262994819;7974.84050319002;8111.9594402027615;8155.9184408157535;8158.551279679437;8185.140560241089;7060.576365418091;7189.388901943394;7299.5255308404785;7332.890006650011;7419.740309089156;7334.6699398526125;7355.485116041826;7369.963150184215;7376.446766492427;7416.221296763762;7702.114256860533;7773.144954055162;7785.883211751941;7793.220677932161;7793.571353575608;6923.376896079377;7075.71697132109;7085.964570177116;7165.426765858823;7175.21072682015;7064.646767661494;7109.431245500451;7110.25342339047;7115.501914865909;7115.644217789193 13:21:00 INFO - PROCESS | 15464 | |4;prototype.html;338.6478062814673;342.21632461662784;343.42990635545;346.9809160496172;354.8828886467466;5613.550915926721;5634.887302253953;5649.180868774025;5677.630953987988;5691.4877661010505;5568.136938774486;5571.860703482415;5593.356763972144;5597.496225339719;5599.664020158793;4249.638780703636;4287.056847493562;4355.390245365651;4363.803628836694;4365.257906155961;4317.481902171744;4318.935215971763;4335.43639326887;4349.977260573833;4352.673549483786;4299.914001719963;4309.612134907858;4312.762798046107;4313.266744653401;4327.554931463728;4053.310937140693;4274.209271284792;4274.316109422478;4325.680667396443;4327.242732521812;3722.4788529605876;3737.4767532545466;3742.4947632069593;3749.15643980105;3759.293308817647;5434.429384914567;5440.510354068113;5450.127979523258;5467.195825377616;5469.398366179717;4812.350332705075;4882.487338829407;4945.184044632631;4958.851234462972;4993.825216117455;5821.767129314822;5875.882482350372;5884.352721200665;5895.557833162487;5909.290885093773;4176.227397931392;4177.206330797169;4187.8324867005285;4188.497380314351;4203.495580530325;5871.178035075093;6123.142760013601;6173.259208894917;6183.3816618337805;6193.690315484253;4243.511996120424;4247.936280955788;4263.765492897858;4276.786160691953;4282.5075116361395;4315.611594956469;4330.935035974463;4334.718243314174;4344.109457561192;4350.195213885441;4850.587700045465;4963.528464795839;4971.676841005323;4985.302057711923;4987.807803006079;5938.61399009063;5939.346671866091;5950.256217972754;5962.495751784174;5970.462658360769;1452.469848505309;1462.8829693624484;1465.3918623771015;1465.7288401645517;1468.1191285228776;1002.9699109026741;1011.4891979550428;1012.8733908261468;1022.7085280695115;1029;5608.018596745554;5653.971730141323;5746.367899531048;5749.310082790092;5750.856228594235;6012.579119461596;6024.337322894478;6058.757649694051;6066.514678825772;6092.664903430265;5499.367572729107;5645;5669;5681.829545113653;5737.110747834093;3252.9590531030317;3257.9674203257664;3263.7062664360324;3266.983665081659;3267.6895694908944;6132.478739307119;6284.528660350492;6290.622562646256;6303.086052522359;6404.135441715402;6032.125341825411;6217.7823776168525;6345.809625711236;6365.2679941806355;6376.808695739135;6123.693815309217;6295.622262664163;6340.682965851597;6349.52378571609;6353.7140828661895;5778.422157784356;6062.333143354139;6085.726142323518;6148.323684394623;6154.661493617894;5881.9705901470215;6111.633302001894;6113.724882380215;6114.357992410733;6122.357152498924;6324.810255692337;6327.778527751507;6368.834596237301;6374;6376.52176086786;4318;4352.368906508602;4417.867463976086;4435.822567097409;4438.312061630452;6061.242344706911;6087.482563982111;6098.481629061579;6099.329073801967;6103.162029656231;5722.914156287576;5940.405959404198;5969.134475500941;5991.651878327341;6013.098035294741;6007.759689612367;6016.819495415145;6032.306284777132;6037.969810150921;6041.546883983807;5859.20900678403;5897.233359663216;5933.406659334032;5935.347111817783;5937.970310148422;5839.591228613956;5982.162497250475;5997.640141591519;6019.398060193946;6040.184575082308;5808.970955145197;5845.620034697731;5875.471207591338;5887.322957859901;5895.9115613266695 13:21:00 INFO - PROCESS | 15464 | |5;yui.html;777.9066512018559;789.6959670526845;818.6397984886653;855.1875718067835;886.4946980221273;14226.288685565733;14276.785848212285;14289.928550357234;14366.784498232535;15204.08775473471;14195.78706319406;14228.430862765477;14256.28718564073;14259.572212833606;14265.429382824701;692.8718187135383;825.3933358981144;860.2300940658107;861.1818772166467;864.2308345572445;833.954132522711;839.9076101628816;840.6637345061963;840.8318336332727;841.381584535366;884.2925659472396;888;896.2829736211038;897.9820403591924;898.716904175186;728.9198188199321;855.3670283989834;882.2236431939916;883.4787475389487;884.460479107747;641.5861769158913;645.9547831651786;648.0311933659162;650.6714109374735;652.8988006858945;13574.185548867;13612.523561675294;13636.318184090756;13656.24890631015;13679.726405471834;13985.510507132201;14215.289235538181;14350.928245358811;14440.422383104664;14675.192864392455;11671.12466565011;11793.528258869635;11820.88179118215;11855.051595872395;12069.456874440672;3865.942010869839;3902.0635047588376;3966.246413181515;4037.051292946155;4053.695972802022;56056.439435605935;56487;57889.13166302509;58063.70968145132;58218.417815821726;11186.552537898393;11229.775404491864;11401.771964560663;11491.678456977388;11574.363410012531;20497.897510512354;20591;20594.38216853497;20608.69086963697;20623.896880515502;8521.701740439055;8620.137986201455;8672.089430609822;8709.912900871037;8978.955105224431;4865.148598995162;4866.31871537985;4874.7562621868765;4889.315495830587;5087.389513258433;3543.7165026797793;3644.526211592476;3660.8352624131444;3661.9450708239397;3663.3589121904092;546.529984213576;611.9020956646915;645.3643161485933;649.8895187818082;653.7515744017243;688.786476192382;690.8169335126196;705.340506626306;736.443984791479;745.9216782237895;9310.72067837966;9322.30082743797;9369.250459963187;9729.756756081013;9784.168345690696;597.4443767296369;731.6890321613399;732.6226993098559;749.0973377080713;772.9884051739228;4418.80115394808;4539.251023581072;4539.6368290536675;4553.180427523078;4553.954460455419;65049;65224.67387663126;65854;65937.6703116491;66279.33720662732;59322;59386.40613593895;59910.70044649749;60129.39870601326;60461.39538604645;52992.20511692328;54076.45923540793;54384.728076359366;54769.45230547723;56491.43508564862;8709.782255443664;8711.172438618321;8853.15894989975;8921.509316987627;8984.32617553673;34800.129996750285;34846.825765871006;35662;35959.64040359563;37129.443058354685;44707.776461117486;48803.75598121987;49558.75220624018;49780.502194977584;50010.749946250035;11820.468078936641;12044.518219271482;12062.155649104478;12148.75702485963;12170.087243456954;13365.39855706476;13679.31603419845;13774.86225137776;13926.791098133333;13950.720985580434;12809.487620495449;12890.48438062467;13074.542391016268;13095.607131786062;13593.45626174942;12579.811302830647;12580.559680411141;12784.232946023269;12875.227486350848;13062.150960187557;12279.815802762787;12668.556600519307;12701.237925724487;12777.744445111231;12997.415116319598;10032.626019875532;11041.503132358903;11077.224594278323;11324.150688698215;11381.032612228053;11139.220254582426;11197.440127993405;11488.942555287504;11594.94202528982;11622.302661840316 13:21:00 INFO - PROCESS | 15464 | __end_tp_report 13:21:00 INFO - PROCESS | 15464 | __start_cc_report 13:21:00 INFO - PROCESS | 15464 | _x_x_mozilla_cycle_collect,797 13:21:00 INFO - PROCESS | 15464 | __end_cc_report 13:21:00 INFO - PROCESS | 15464 | __startTimestamp1460146860120__endTimestamp 13:21:00 INFO - PROCESS | 15464 | 13:21:00 INFO - PROCESS | 15464 | ------- Summary: start ------- 13:21:00 INFO - PROCESS | 15464 | Number of tests: 6 13:21:00 INFO - PROCESS | 15464 | 13:21:00 INFO - PROCESS | 15464 | [#0] dojo.html Cycles:165 Average:5304.51 Median:5535.53 stddev:590.19 (10.7%) stddev-sans-first:566.78 13:21:00 INFO - PROCESS | 15464 | Values: 3128.4 3164.1 3167.5 3193.4 3215.8 5231.8 5352.3 5359.2 5369.2 5450.0 5312.6 5326.2 5353.6 5383.1 5409.9 4779.5 4793.3 4815.2 4830.3 4906.6 4828.8 4873.3 4874.4 4881.3 4924.4 4733.5 4781.1 4792.5 4807.0 4857.5 4866.5 4879.1 4893.7 4900.6 4932.3 4854.9 4878.2 4879.5 4879.5 4888.6 5134.5 5227.6 5278.9 5340.8 5362.7 5674.5 5677.0 5701.7 5704.0 5705.4 5617.9 5772.0 5773.3 5774.4 5775.5 5298.3 5350.5 5354.5 5392.3 5394.3 5883.1 5883.2 5883.5 5892.4 5893.1 5517.1 5572.9 5655.0 5655.2 5658.0 5723.8 5724.5 5726.1 5740.3 5779.9 5691.6 5696.6 5697.8 5703.0 5703.9 5589.4 5617.4 5692.4 5694.3 5739.7 4341.8 4359.1 4364.2 4393.5 4402.4 3887.0 3902.1 3907.9 3931.1 3931.8 5255.3 5299.4 5316.8 5407.2 5413.9 5682.7 5692.0 5697.8 5703.6 5744.7 5328.4 5371.0 5372.1 5372.1 5373.5 4836.6 4865.3 4948.5 4953.8 4956.6 5831.1 5831.7 5835.5 5836.0 5836.1 5648.1 5650.7 5652.3 5663.4 5669.0 5831.4 5869.3 5875.5 5918.0 5932.2 5626.9 5662.9 5665.5 5670.7 5671.3 5606.2 5691.2 5761.1 5765.9 5768.5 5552.5 5594.4 5595.5 5632.5 5647.6 5577.1 5589.4 5593.1 5594.7 5594.9 5412.6 5444.1 5489.7 5518.0 5562.9 5611.5 5654.5 5657.9 5663.3 5699.5 5531.6 5534.3 5535.5 5535.7 5565.8 13:21:00 INFO - PROCESS | 15464 | 13:21:00 INFO - PROCESS | 15464 | [#1] ext.html Cycles:180 Average:52140.57 Median:182957.49 stddev:96073.09 (52.5%) stddev-sans-first:96264.71 13:21:00 INFO - PROCESS | 15464 | Values: 615.9 645.4 661.7 662.9 672.8 30570.0 37231.3 38940.2 38958.2 39013.2 41279.2 41848.0 41989.8 42071.2 42180.4 7749.5 8391.7 8550.5 8563.7 8567.4 7843.1 7947.6 7948.3 10211.2 10590.1 10197.5 10279.9 10293.8 10294.4 10304.5 10064.2 10229.8 10235.9 10238.8 10243.3 7865.7 10142.4 10492.9 10493.7 10502.6 35547.8 36189.1 36207.1 36259.8 36268.0 3467.8 3516.7 3589.5 3625.0 3762.5 28895.8 29017.4 29103.7 32349.0 33307.3 4285.5 4301.8 4381.5 4384.5 4387.1 284800.8 285406.0 285412.0 285432.0 286037.0 35183.6 56852.4 57255.4 57270.7 57304.4 34758.5 35043.3 35051.0 35055.5 35097.0 14535.3 14811.1 14812.9 14820.1 14840.8 11007.4 11009.3 11013.6 11021.5 11076.7 8524.0 8694.6 8711.7 8719.6 8773.7 3381.8 3431.0 3440.3 3443.5 3459.1 1051.7 1062.0 1074.2 1110.7 1162.6 31693.0 31986.4 32148.8 32315.4 32733.0 1129.8 1159.4 1214.1 1216.8 1301.0 16411.8 17161.2 17179.5 17237.6 17255.1 422022.0 424463.0 426312.7 426938.0 427749.0 54386.2 54555.2 55002.7 55122.4 55142.7 1250.8 1344.1 1358.4 1374.7 1436.8 29830.7 31187.8 31486.2 31884.0 32016.8 45967.0 46330.5 48219.8 48356.3 48401.5 362290.0 369021.0 370540.0 371222.0 371284.0 37179.4 43815.0 47700.8 48067.3 48762.5 48211.3 48778.0 49377.8 49650.0 49909.5 39534.6 40538.4 41094.2 41237.6 41542.0 41528.4 41558.0 41706.0 41767.6 43065.8 40719.4 41406.2 42264.2 42780.4 42832.8 34369.7 36402.1 36584.3 36706.3 36913.8 27880.7 28303.9 28333.0 28359.6 28403.9 13:21:00 INFO - PROCESS | 15464 | 13:21:00 INFO - PROCESS | 15464 | [#2] jquery.html Cycles:180 Average:28084.18 Median:17780.00 stddev:83350.50 (468.8%) stddev-sans-first:83558.40 13:21:00 INFO - PROCESS | 15464 | Values: 398.8 402.3 403.7 409.7 416.4 14608.6 17486.6 18095.4 18109.5 18512.3 16458.1 16831.0 17756.0 18792.7 18815.3 5297.3 5588.9 5588.9 5653.1 5919.8 3843.3 5543.2 5568.2 5613.5 5829.5 5811.2 5812.0 5829.9 5830.9 5836.2 5684.7 5775.5 5783.8 5786.7 5790.5 5526.1 5635.5 5642.6 5643.8 5646.7 12524.4 13276.8 13278.9 13287.9 13289.0 2215.8 2347.2 2405.7 2578.3 2784.3 9725.7 9818.0 9911.3 10023.2 10340.7 1840.6 1919.2 1935.5 1953.1 1981.2 63696.7 67865.3 69758.0 70425.0 76210.6 10378.0 10587.2 10762.8 10777.1 10829.8 13459.7 13955.4 15187.6 15259.5 15266.5 7527.9 7898.9 7985.0 8062.5 8203.1 7478.7 7491.3 7606.8 7828.2 7848.1 4458.2 4562.9 4688.5 4776.6 4859.1 1917.3 1950.9 1961.7 1981.1 1981.9 918.6 980.1 994.8 1021.6 1061.3 18784.4 18832.8 19295.6 19398.7 19404.5 956.2 992.7 1000.6 1002.3 1008.7 9452.5 10123.1 10163.4 10169.5 10265.6 492809.0 503124.0 507960.0 515293.0 516757.0 89403.0 91584.0 92933.0 92995.0 93059.5 1054.7 1076.3 1102.3 1102.5 1114.6 15463.2 15717.9 15776.2 15882.4 15895.8 26219.4 32775.7 33686.7 34330.5 35308.3 47817.3 48018.8 48041.0 48364.8 48616.8 7182.3 7717.8 8388.2 8438.3 8662.9 10858.6 12771.7 13245.7 13479.6 13498.5 11482.1 11697.5 11827.3 11834.2 11988.6 11346.3 11645.1 11708.1 11805.5 11960.5 11469.1 11700.8 11822.0 12091.8 12189.5 7881.5 8050.9 8054.1 8131.3 8150.9 8833.6 10844.3 10911.1 11539.6 11930.7 13:21:00 INFO - PROCESS | 15464 | 13:21:00 INFO - PROCESS | 15464 | [#3] mootools.html Cycles:180 Average:5886.49 Median:5208.89 stddev:3154.49 (60.6%) stddev-sans-first:3145.00 13:21:00 INFO - PROCESS | 15464 | Values: 1361.7 1529.3 1546.3 1731.3 1869.1 8109.4 8371.5 8377.0 8382.0 8457.5 8173.8 8315.6 8324.0 8339.7 8345.3 1989.1 2277.5 2310.6 2332.5 2367.8 2200.6 2213.3 2214.6 2215.6 2218.9 2145.1 2170.2 2173.2 2176.3 2176.4 1898.9 2224.5 2279.7 2286.8 2288.2 2202.2 2204.9 2211.0 2211.9 2267.3 8176.6 8191.4 8264.3 8264.7 8283.4 5015.2 5208.1 5209.7 5229.2 5229.9 3578.4 3589.2 3593.3 3644.2 3671.3 1125.4 1146.4 1159.7 1179.7 1197.3 11643.9 11653.8 11660.7 11665.8 11667.8 4366.1 4477.6 4606.8 4639.5 4642.9 9746.3 9786.1 9788.6 9791.0 9803.1 4704.2 5156.6 5198.5 5204.3 5204.7 4367.5 4397.0 4398.0 4562.3 4644.5 3709.5 3790.4 3813.5 3836.5 3998.1 1254.7 1262.8 1263.7 1266.0 1266.7 1414.0 1417.7 1441.1 1451.7 1461.1 7928.1 7942.1 7942.9 7952.3 8010.1 468.6 480.3 482.2 483.5 486.1 6163.3 6200.6 6201.0 6243.0 6246.2 9836.3 10257.7 10354.3 10376.2 10393.2 10091.8 10242.4 10259.1 10267.4 10292.7 7900.0 7916.1 7924.3 8005.3 8015.3 7656.4 7919.1 7925.8 7950.5 7951.9 9533.3 9578.7 9601.6 9613.1 9720.6 9648.1 9716.6 9834.2 9834.8 9979.4 6850.9 7234.2 7348.0 7418.0 7486.9 7974.8 8112.0 8155.9 8158.6 8185.1 7060.6 7189.4 7299.5 7332.9 7419.7 7334.7 7355.5 7370.0 7376.4 7416.2 7702.1 7773.1 7785.9 7793.2 7793.6 6923.4 7075.7 7086.0 7165.4 7175.2 7064.6 7109.4 7110.3 7115.5 7115.6 13:21:00 INFO - PROCESS | 15464 | 13:21:00 INFO - PROCESS | 15464 | [#4] prototype.html Cycles:180 Average:4978.77 Median:5651.58 stddev:1487.83 (26.3%) stddev-sans-first:1450.67 13:21:00 INFO - PROCESS | 15464 | Values: 338.6 342.2 343.4 347.0 354.9 5613.6 5634.9 5649.2 5677.6 5691.5 5568.1 5571.9 5593.4 5597.5 5599.7 4249.6 4287.1 4355.4 4363.8 4365.3 4317.5 4318.9 4335.4 4350.0 4352.7 4299.9 4309.6 4312.8 4313.3 4327.6 4053.3 4274.2 4274.3 4325.7 4327.2 3722.5 3737.5 3742.5 3749.2 3759.3 5434.4 5440.5 5450.1 5467.2 5469.4 4812.4 4882.5 4945.2 4958.9 4993.8 5821.8 5875.9 5884.4 5895.6 5909.3 4176.2 4177.2 4187.8 4188.5 4203.5 5871.2 6123.1 6173.3 6183.4 6193.7 4243.5 4247.9 4263.8 4276.8 4282.5 4315.6 4330.9 4334.7 4344.1 4350.2 4850.6 4963.5 4971.7 4985.3 4987.8 5938.6 5939.3 5950.3 5962.5 5970.5 1452.5 1462.9 1465.4 1465.7 1468.1 1003.0 1011.5 1012.9 1022.7 1029.0 5608.0 5654.0 5746.4 5749.3 5750.9 6012.6 6024.3 6058.8 6066.5 6092.7 5499.4 5645.0 5669.0 5681.8 5737.1 3253.0 3258.0 3263.7 3267.0 3267.7 6132.5 6284.5 6290.6 6303.1 6404.1 6032.1 6217.8 6345.8 6365.3 6376.8 6123.7 6295.6 6340.7 6349.5 6353.7 5778.4 6062.3 6085.7 6148.3 6154.7 5882.0 6111.6 6113.7 6114.4 6122.4 6324.8 6327.8 6368.8 6374.0 6376.5 4318.0 4352.4 4417.9 4435.8 4438.3 6061.2 6087.5 6098.5 6099.3 6103.2 5722.9 5940.4 5969.1 5991.7 6013.1 6007.8 6016.8 6032.3 6038.0 6041.5 5859.2 5897.2 5933.4 5935.3 5938.0 5839.6 5982.2 5997.6 6019.4 6040.2 5809.0 5845.6 5875.5 5887.3 5895.9 13:21:00 INFO - PROCESS | 15464 | 13:21:00 INFO - PROCESS | 15464 | [#5] yui.html Cycles:180 Average:15551.52 Median:4709.55 stddev:18300.90 (388.6%) stddev-sans-first:18318.61 13:21:00 INFO - PROCESS | 15464 | Values: 777.9 789.7 818.6 855.2 886.5 14226.3 14276.8 14289.9 14366.8 15204.1 14195.8 14228.4 14256.3 14259.6 14265.4 692.9 825.4 860.2 861.2 864.2 834.0 839.9 840.7 840.8 841.4 884.3 888.0 896.3 898.0 898.7 728.9 855.4 882.2 883.5 884.5 641.6 646.0 648.0 650.7 652.9 13574.2 13612.5 13636.3 13656.2 13679.7 13985.5 14215.3 14350.9 14440.4 14675.2 11671.1 11793.5 11820.9 11855.1 12069.5 3865.9 3902.1 3966.2 4037.1 4053.7 56056.4 56487.0 57889.1 58063.7 58218.4 11186.6 11229.8 11401.8 11491.7 11574.4 20497.9 20591.0 20594.4 20608.7 20623.9 8521.7 8620.1 8672.1 8709.9 8979.0 4865.1 4866.3 4874.8 4889.3 5087.4 3543.7 3644.5 3660.8 3661.9 3663.4 546.5 611.9 645.4 649.9 653.8 688.8 690.8 705.3 736.4 745.9 9310.7 9322.3 9369.3 9729.8 9784.2 597.4 731.7 732.6 749.1 773.0 4418.8 4539.3 4539.6 4553.2 4554.0 65049.0 65224.7 65854.0 65937.7 66279.3 59322.0 59386.4 59910.7 60129.4 60461.4 52992.2 54076.5 54384.7 54769.5 56491.4 8709.8 8711.2 8853.2 8921.5 8984.3 34800.1 34846.8 35662.0 35959.6 37129.4 44707.8 48803.8 49558.8 49780.5 50010.7 11820.5 12044.5 12062.2 12148.8 12170.1 13365.4 13679.3 13774.9 13926.8 13950.7 12809.5 12890.5 13074.5 13095.6 13593.5 12579.8 12580.6 12784.2 12875.2 13062.2 12279.8 12668.6 12701.2 12777.7 12997.4 10032.6 11041.5 11077.2 11324.2 11381.0 11139.2 11197.4 11488.9 11594.9 11622.3 13:21:00 INFO - PROCESS | 15464 | -------- Summary: end -------- 13:21:00 INFO - PROCESS | 15464 | 13:21:00 INFO - TEST-INFO | 15464: exit 0 13:21:00 INFO - TEST-OK | dromaeo_css | took 1111288ms 13:21:00 INFO - TEST-START | kraken 13:21:00 INFO - operating with platform_type : linux_ 13:21:00 INFO - Initialising browser for kraken test... 13:21:00 INFO - TEST-INFO | started process 15649 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbcgFwX/profile http://localhost:60750/getInfo.html) 13:21:04 INFO - PROCESS | 15649 | __metrics Screen width/height:1600/1200 13:21:04 INFO - PROCESS | 15649 | colorDepth:24 13:21:04 INFO - PROCESS | 15649 | Browser inner width/height: 1024/697 13:21:04 INFO - PROCESS | 15649 | __metrics 13:21:05 ERROR - PROCESS | 15649 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:21:06 INFO - TEST-INFO | 15649: exit 0 13:21:06 INFO - Browser initialized. 13:21:06 INFO - Running cycle 1/1 for kraken test... 13:21:06 INFO - TEST-INFO | started process 15728 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbcgFwX/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:21:18 INFO - PROCESS | 15728 | RSS: Main: 152567808 13:21:18 INFO - PROCESS | 15728 | 13:21:20 INFO - PROCESS | 15728 | Cycle 1(1): loaded http://localhost:60750/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60750/tests/kraken/driver.html?testName=audio-beat-detection) 13:21:21 INFO - PROCESS | 15728 | RSS: Main: 208142336 13:21:21 INFO - PROCESS | 15728 | 13:21:24 INFO - PROCESS | 15728 | Cycle 1(1): loaded http://localhost:60750/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60750/tests/kraken/driver.html?testName=audio-dft) 13:21:24 INFO - PROCESS | 15728 | RSS: Main: 193892352 13:21:24 INFO - PROCESS | 15728 | 13:21:27 INFO - PROCESS | 15728 | Cycle 1(1): loaded http://localhost:60750/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60750/tests/kraken/driver.html?testName=audio-fft) 13:21:28 INFO - PROCESS | 15728 | RSS: Main: 265273344 13:21:28 INFO - PROCESS | 15728 | 13:21:30 INFO - PROCESS | 15728 | Cycle 1(1): loaded http://localhost:60750/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60750/tests/kraken/driver.html?testName=audio-oscillator) 13:21:30 INFO - PROCESS | 15728 | RSS: Main: 173391872 13:21:30 INFO - PROCESS | 15728 | 13:21:32 INFO - PROCESS | 15728 | Cycle 1(1): loaded http://localhost:60750/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60750/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:21:33 INFO - PROCESS | 15728 | RSS: Main: 177803264 13:21:33 INFO - PROCESS | 15728 | 13:21:36 INFO - PROCESS | 15728 | Cycle 1(1): loaded http://localhost:60750/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60750/tests/kraken/driver.html?testName=imaging-darkroom) 13:21:37 INFO - PROCESS | 15728 | RSS: Main: 213565440 13:21:37 INFO - PROCESS | 15728 | 13:21:40 INFO - PROCESS | 15728 | Cycle 1(1): loaded http://localhost:60750/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60750/tests/kraken/driver.html?testName=imaging-desaturate) 13:21:41 INFO - PROCESS | 15728 | RSS: Main: 214224896 13:21:41 INFO - PROCESS | 15728 | 13:21:43 INFO - PROCESS | 15728 | Cycle 1(1): loaded http://localhost:60750/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60750/tests/kraken/driver.html?testName=json-parse-financial) 13:21:44 INFO - PROCESS | 15728 | RSS: Main: 214511616 13:21:44 INFO - PROCESS | 15728 | 13:21:45 INFO - PROCESS | 15728 | Cycle 1(1): loaded http://localhost:60750/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60750/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:21:46 INFO - PROCESS | 15728 | RSS: Main: 200560640 13:21:46 INFO - PROCESS | 15728 | 13:21:48 INFO - PROCESS | 15728 | Cycle 1(1): loaded http://localhost:60750/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60750/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:21:48 INFO - PROCESS | 15728 | RSS: Main: 204529664 13:21:48 INFO - PROCESS | 15728 | 13:21:50 INFO - PROCESS | 15728 | Cycle 1(1): loaded http://localhost:60750/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60750/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:21:51 INFO - PROCESS | 15728 | RSS: Main: 219254784 13:21:51 INFO - PROCESS | 15728 | 13:21:54 INFO - PROCESS | 15728 | Cycle 1(1): loaded http://localhost:60750/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60750/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:21:54 INFO - PROCESS | 15728 | RSS: Main: 223543296 13:21:54 INFO - PROCESS | 15728 | 13:21:57 INFO - PROCESS | 15728 | Cycle 1(1): loaded http://localhost:60750/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60750/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:21:58 INFO - PROCESS | 15728 | RSS: Main: 219152384 13:21:58 INFO - PROCESS | 15728 | 13:21:59 INFO - PROCESS | 15728 | Cycle 1(1): loaded http://localhost:60750/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60750/tests/kraken/driver.html?testName=ai-astar) 13:22:00 INFO - PROCESS | 15728 | RSS: Main: 282484736 13:22:00 INFO - PROCESS | 15728 | 13:22:00 INFO - PROCESS | 15728 | __start_tp_report 13:22:00 INFO - PROCESS | 15728 | _x_x_mozilla_page_load 13:22:00 INFO - PROCESS | 15728 | _x_x_mozilla_page_load_details 13:22:00 INFO - PROCESS | 15728 | |i|pagename|runs| 13:22:00 INFO - PROCESS | 15728 | |0;ai-astar;110;112;105;110;111;110;100;111;110;109 13:22:00 INFO - PROCESS | 15728 | |1;audio-beat-detection;166;128;158;177;129;161;168;124;181;127 13:22:00 INFO - PROCESS | 15728 | |2;audio-dft;163;162;161;161;160;160;162;161;162;161 13:22:00 INFO - PROCESS | 15728 | |3;audio-fft;73;76;126;111;72;73;73;124;104;72 13:22:00 INFO - PROCESS | 15728 | |4;audio-oscillator;92;93;143;92;93;92;154;94;93;154 13:22:00 INFO - PROCESS | 15728 | |5;imaging-gaussian-blur;116;116;116;117;117;118;117;117;117;116 13:22:00 INFO - PROCESS | 15728 | |6;imaging-darkroom;145;145;147;146;145;145;145;147;145;145 13:22:00 INFO - PROCESS | 15728 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 13:22:00 INFO - PROCESS | 15728 | |8;json-parse-financial;58;59;60;59;58;58;60;78;59;56 13:22:00 INFO - PROCESS | 15728 | |9;json-stringify-tinderbox;65;64;63;65;64;64;64;64;64;65 13:22:00 INFO - PROCESS | 15728 | |10;stanford-crypto-aes;79;79;78;78;80;83;80;79;81;81 13:22:00 INFO - PROCESS | 15728 | |11;stanford-crypto-ccm;131;129;130;133;128;129;128;129;165;132 13:22:00 INFO - PROCESS | 15728 | |12;stanford-crypto-pbkdf2;170;164;164;164;166;167;163;164;165;163 13:22:00 INFO - PROCESS | 15728 | |13;stanford-crypto-sha256-iterative;69;70;68;69;68;69;71;69;68;70 13:22:00 INFO - PROCESS | 15728 | __end_tp_report 13:22:00 INFO - PROCESS | 15728 | __start_cc_report 13:22:00 INFO - PROCESS | 15728 | _x_x_mozilla_cycle_collect,1632 13:22:00 INFO - PROCESS | 15728 | __end_cc_report 13:22:00 INFO - PROCESS | 15728 | __startTimestamp1460146920132__endTimestamp 13:22:00 INFO - PROCESS | 15728 | 13:22:00 INFO - PROCESS | 15728 | ------- Summary: start ------- 13:22:00 INFO - PROCESS | 15728 | Number of tests: 14 13:22:00 INFO - PROCESS | 15728 | 13:22:00 INFO - PROCESS | 15728 | [#0] ai-astar Cycles:10 Average:108.80 Median:110.00 stddev:3.61 (3.3%) stddev-sans-first:3.81 13:22:00 INFO - PROCESS | 15728 | Values: 110.0 112.0 105.0 110.0 111.0 110.0 100.0 111.0 110.0 109.0 13:22:00 INFO - PROCESS | 15728 | 13:22:00 INFO - PROCESS | 15728 | [#1] audio-beat-detection Cycles:10 Average:151.90 Median:163.50 stddev:22.48 (13.8%) stddev-sans-first:23.26 13:22:00 INFO - PROCESS | 15728 | Values: 166.0 128.0 158.0 177.0 129.0 161.0 168.0 124.0 181.0 127.0 13:22:00 INFO - PROCESS | 15728 | 13:22:00 INFO - PROCESS | 15728 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.95 (0.6%) stddev-sans-first:0.78 13:22:00 INFO - PROCESS | 15728 | Values: 163.0 162.0 161.0 161.0 160.0 160.0 162.0 161.0 162.0 161.0 13:22:00 INFO - PROCESS | 15728 | 13:22:00 INFO - PROCESS | 15728 | [#3] audio-fft Cycles:10 Average:90.40 Median:72.50 stddev:23.09 (31.8%) stddev-sans-first:23.62 13:22:00 INFO - PROCESS | 15728 | Values: 73.0 76.0 126.0 111.0 72.0 73.0 73.0 124.0 104.0 72.0 13:22:00 INFO - PROCESS | 15728 | 13:22:00 INFO - PROCESS | 15728 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:92.50 stddev:28.00 (30.3%) stddev-sans-first:28.93 13:22:00 INFO - PROCESS | 15728 | Values: 92.0 93.0 143.0 92.0 93.0 92.0 154.0 94.0 93.0 154.0 13:22:00 INFO - PROCESS | 15728 | 13:22:00 INFO - PROCESS | 15728 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 13:22:00 INFO - PROCESS | 15728 | Values: 116.0 116.0 116.0 117.0 117.0 118.0 117.0 117.0 117.0 116.0 13:22:00 INFO - PROCESS | 15728 | 13:22:00 INFO - PROCESS | 15728 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 13:22:00 INFO - PROCESS | 15728 | Values: 145.0 145.0 147.0 146.0 145.0 145.0 145.0 147.0 145.0 145.0 13:22:00 INFO - PROCESS | 15728 | 13:22:00 INFO - PROCESS | 15728 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 13:22:00 INFO - PROCESS | 15728 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 13:22:00 INFO - PROCESS | 15728 | 13:22:00 INFO - PROCESS | 15728 | [#8] json-parse-financial Cycles:10 Average:60.50 Median:59.00 stddev:6.26 (10.6%) stddev-sans-first:6.57 13:22:00 INFO - PROCESS | 15728 | Values: 58.0 59.0 60.0 59.0 58.0 58.0 60.0 78.0 59.0 56.0 13:22:00 INFO - PROCESS | 15728 | 13:22:00 INFO - PROCESS | 15728 | [#9] json-stringify-tinderbox Cycles:10 Average:64.20 Median:64.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 13:22:00 INFO - PROCESS | 15728 | Values: 65.0 64.0 63.0 65.0 64.0 64.0 64.0 64.0 64.0 65.0 13:22:00 INFO - PROCESS | 15728 | 13:22:00 INFO - PROCESS | 15728 | [#10] stanford-crypto-aes Cycles:10 Average:79.80 Median:80.00 stddev:1.55 (1.9%) stddev-sans-first:1.62 13:22:00 INFO - PROCESS | 15728 | Values: 79.0 79.0 78.0 78.0 80.0 83.0 80.0 79.0 81.0 81.0 13:22:00 INFO - PROCESS | 15728 | 13:22:00 INFO - PROCESS | 15728 | [#11] stanford-crypto-ccm Cycles:10 Average:133.40 Median:130.50 stddev:11.23 (8.6%) stddev-sans-first:11.87 13:22:00 INFO - PROCESS | 15728 | Values: 131.0 129.0 130.0 133.0 128.0 129.0 128.0 129.0 165.0 132.0 13:22:00 INFO - PROCESS | 15728 | 13:22:00 INFO - PROCESS | 15728 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.00 Median:164.50 stddev:2.16 (1.3%) stddev-sans-first:1.33 13:22:00 INFO - PROCESS | 15728 | Values: 170.0 164.0 164.0 164.0 166.0 167.0 163.0 164.0 165.0 163.0 13:22:00 INFO - PROCESS | 15728 | 13:22:00 INFO - PROCESS | 15728 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.00 stddev:0.99 (1.4%) stddev-sans-first:1.05 13:22:00 INFO - PROCESS | 15728 | Values: 69.0 70.0 68.0 69.0 68.0 69.0 71.0 69.0 68.0 70.0 13:22:00 INFO - PROCESS | 15728 | -------- Summary: end -------- 13:22:00 INFO - PROCESS | 15728 | 13:22:00 INFO - TEST-INFO | 15728: exit 0 13:22:01 INFO - TEST-OK | kraken | took 60185ms 13:22:01 INFO - SUITE-END | took 1171s 13:22:01 INFO - Completed test suite (00:19:31) 13:22:01 INFO - javascript benchmark 13:22:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3128.389963957028, 3164.129864287322, 3167.4773662345715, 3193.441147799135, 3215.807051576905, 5231.816886408977, 5352.304200453946, 5359.196120581914, 5369.167778994252, 5450.04624190766, 5312.6281160318795, 5326.174442961337, 5353.625246232766, 5383.084875571152, 5409.864753381157, 4779.474257831635, 4793.32893394925, 4815.157347464197, 4830.3237546743485, 4906.558409743122, 4828.806847726087, 4873.34209881665, 4874.415070191564, 4881.316615673791, 4924.433690125627, 4733.526647335256, 4781.091592597395, 4792.496787837262, 4807.03859228154, 4857.465678775332, 4866.537678920532, 4879.072976134523, 4893.681910675795, 4900.558949694509, 4932.260160975882, 4854.854354369375, 4878.219484882402, 4879.463259041502, 4879.536444037846, 4888.584470320027, 5134.537891589737, 5227.634065615409, 5278.947210527922, 5340.813071542516, 5362.705051222181, 5674.546036317085, 5677.0, 5701.714914254312, 5704.0, 5705.372409035002, 5617.943820561783, 5772.0, 5773.307203135609, 5774.393688662714, 5775.509081728058, 5298.311219541473, 5350.545203657655, 5354.5180933715765, 5392.272043274186, 5394.298741163623, 5883.058710606282, 5883.235179426732, 5883.499902508249, 5892.381299963527, 5893.057110862242, 5517.089680202802, 5572.888542229132, 5655.0, 5655.208270842086, 5658.009848276535, 5723.77104915807, 5724.4561766632105, 5726.141078838207, 5740.339860915965, 5779.88440231193, 5691.573132015115, 5696.629719068247, 5697.772089116472, 5702.971485142548, 5703.914441283384, 5589.35722391922, 5617.41017193197, 5692.37383887772, 5694.288213973254, 5739.7417116229035, 4341.826326946887, 4359.084592235666, 4364.170807546556, 4393.494748104009, 4402.405675233803, 3886.96113038866, 3902.083010492532, 3907.9218415631526, 3931.1351502669368, 3931.783751893616, 5255.343082114736, 5299.417064122943, 5316.787328506816, 5407.215953686693, 5413.945860541423, 5682.659040457585, 5691.9715401423555, 5697.772089116389, 5703.572232082611, 5744.712764361765, 5328.3605967284175, 5371.033214021436, 5372.059889519319, 5372.140457526777, 5373.516383525502, 4836.637252206098, 4865.270209468608, 4948.455669876311, 4953.8266160684925, 4956.553910148104, 5831.125331200269, 5831.650100993954, 5835.4748072673665, 5836.0, 5836.095405212199, 5648.096304591246, 5650.660960342392, 5652.265205523256, 5663.405342439067, 5669.036263835075, 5831.4168583141345, 5869.325027621878, 5875.50058245054, 5917.970410148094, 5932.199153114447, 5626.887462250814, 5662.915056274242, 5665.546756259407, 5670.688112153706, 5671.347795003628, 5606.159076138611, 5691.174779657009, 5761.135829625589, 5765.884682306414, 5768.53851691872, 5552.52803511706, 5594.38461769197, 5595.468430499096, 5632.493075623213, 5647.604667673223, 5577.079781836114, 5589.385167631639, 5593.105103183634, 5594.692291923983, 5594.86012849682, 5412.648177868426, 5444.128939369682, 5489.725513724377, 5518.0, 5562.888742225214, 5611.5230205433, 5654.547636189012, 5657.858553536194, 5663.263775709296, 5699.487046165865, 5531.612787104864, 5534.280543529316, 5535.529479994246, 5535.695536745357, 5565.833025009256], "value": 5265.810652769825, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [615.9322474527801, 645.3514218210697, 661.6658587413359, 662.9138212032436, 672.8183390484569, 30570.0, 37231.255374892484, 38940.22119557607, 38958.22083558327, 39013.21973560527, 41279.17441651173, 41848.0, 41989.79005104978, 42071.15857682844, 42180.36729449061, 7749.457537972344, 8391.706290279826, 8550.486970781772, 8563.743087707378, 8567.35744819138, 7843.137254901984, 7947.602619869012, 7948.324392426651, 10211.234157438184, 10590.09984151348, 10197.541110650038, 10279.897201028007, 10293.794124117514, 10294.382337059764, 10304.536295866666, 10064.245181611372, 10229.795404091876, 10235.897641023643, 10238.795224095551, 10243.28297019209, 7865.7246996355425, 10142.442165680885, 10492.895071049268, 10493.685189444328, 10502.632407865687, 35547.82226088879, 36189.095272618135, 36207.094822629646, 36259.81870090659, 36268.0, 3467.7745946513396, 3516.6659167379057, 3589.4795254688183, 3624.981875090634, 3762.5108735864164, 28895.823188607315, 29017.419651607062, 29103.70896291031, 32349.029529114163, 33307.33385332304, 4285.46431696038, 4301.78491075445, 4381.474223093217, 4384.517703052662, 4387.1445068211715, 284800.75996200106, 285406.0, 285412.0, 285432.0, 286036.9999999979, 35183.64816351804, 56852.43147568554, 57255.42744572584, 57270.713646431504, 57304.42695573074, 34758.47862282068, 35043.29913401769, 35051.0, 35055.4741678875, 35097.0, 14535.27323633814, 14811.111333320036, 14812.92593537047, 14820.110793352218, 14840.777388339184, 11007.449627518592, 11009.339439633648, 11013.614523491638, 11021.504032318566, 11076.723081923017, 8524.0, 8694.565271736388, 8711.651533938699, 8719.60761765722, 8773.692920747742, 3381.7801842880135, 3430.9828450857585, 3440.3119376124373, 3443.517907492903, 3459.08334291413, 1051.7002654243504, 1062.0, 1074.2319241742036, 1110.7278716714457, 1162.616336608917, 31693.0, 31986.360272794413, 32148.83925580357, 32315.35369292648, 32733.0, 1129.8474705914762, 1159.4260840883817, 1214.1136970011764, 1216.7688139253514, 1301.0242318261303, 16411.753823692656, 17161.227744751515, 17179.484615461555, 17237.56906077333, 17255.137243137793, 422022.0, 424463.0, 426312.68436578044, 426938.0, 427749.0, 54386.184207236925, 54555.18167227495, 55002.724986374815, 55122.44877551253, 55142.72428637831, 1250.7748605251143, 1344.1464669934467, 1358.409092044944, 1374.6906945937285, 1436.8347640021323, 29830.70169298279, 31187.84406077955, 31486.212844679067, 31884.0, 32016.839915800272, 45967.0, 46330.536694632625, 48219.75890120527, 48356.27465587949, 48401.5159848397, 362290.0, 369021.0, 370540.0, 371222.0, 371284.0, 37179.44230836486, 43815.0, 47700.761496192295, 48067.27899081587, 48762.5123748758, 48211.27683084827, 48778.0, 49377.75311123421, 49650.0, 49909.500904990484, 39534.604653954244, 40538.39192412057, 41094.1781164369, 41237.58762412457, 41542.0, 41528.37707434451, 41558.0, 41706.0, 41767.58232417637, 43065.78467107644, 40719.389209161294, 41406.171876562905, 42264.1547169061, 42780.358294626225, 42832.78583607187, 34369.656303437645, 36402.146004215276, 36584.26831463409, 36706.26587468182, 36913.815430922674, 27880.721192787812, 28303.858480707466, 28333.0, 28359.57460638051, 28403.857980709963], "value": 18770.857698663072, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.7547658190213, 402.33212866641384, 403.67907513526745, 409.73981521733697, 416.42949159651283, 14608.634784130401, 17486.562835929093, 18095.366662166827, 18109.547261318457, 18512.25950961963, 16458.09480478573, 16830.99014059154, 17756.0, 18792.71810922834, 18815.341463048797, 5297.258383826267, 5588.916166257489, 5588.916166257489, 5653.067243904751, 5919.763209471616, 3843.2889915365745, 5543.196236545698, 5568.248286481334, 5613.522850557708, 5829.533637309005, 5811.157382179603, 5812.041013232812, 5829.941700582982, 5830.854228644275, 5836.15375770513, 5684.658920464785, 5775.537956963432, 5783.797567085174, 5786.681732504731, 5790.507806836403, 5526.06056970312, 5635.464630860061, 5642.576806739511, 5643.774249030034, 5646.717664116778, 12524.373781310898, 13276.800847987288, 13278.933605332008, 13287.933560332136, 13289.0, 2215.7784221577876, 2347.213683416058, 2405.6511805788064, 2578.329634295078, 2784.317842128671, 9725.65960191397, 9817.950910245474, 9911.306208565404, 10023.198144148451, 10340.689779306633, 1840.6410749903773, 1919.193938545814, 1935.535471486833, 1953.0625299856006, 1981.1580078466739, 63696.68151659212, 67865.32134678689, 69758.0, 70425.0, 76210.61894690491, 10378.0, 10587.205959553065, 10762.78474430507, 10777.137828973664, 10829.83755243672, 13459.730805383837, 13955.441782328797, 15187.620309492351, 15259.465918692793, 15266.465673701367, 7527.887081693779, 7898.881516777253, 7984.960075199587, 8062.475939063942, 8203.138670439517, 7478.663460144307, 7491.325780679765, 7606.80982975419, 7828.217178282126, 7848.0974687910475, 4458.152950939311, 4562.8631141065825, 4688.531146885352, 4776.59398951093, 4859.076775412731, 1917.3289348727833, 1950.9219631214592, 1961.7057441383906, 1981.0787983587702, 1981.9009049547753, 918.554501066982, 980.0934135924241, 994.7811481474064, 1021.6219998600566, 1061.2783307350921, 18784.436466906016, 18832.81167188338, 19295.614087718168, 19398.70901936472, 19404.477417935577, 956.2015716876347, 992.6823416506793, 1000.564754331868, 1002.2533212756397, 1008.7326858382535, 9452.480113593681, 10123.088921997056, 10163.390196588229, 10169.491525423698, 10265.589376425009, 492809.0, 503124.0, 507960.0, 515293.0, 516757.0, 89403.0, 91584.0, 92933.0, 92995.0, 93059.53470232605, 1054.7415883108688, 1076.3326737422692, 1102.3385968418884, 1102.459794700607, 1114.5653195253858, 15463.226838657796, 15717.921410393332, 15776.211189440712, 15882.364705411654, 15895.841041589436, 26219.378062193628, 32775.67224327726, 33686.663133368354, 34330.48504272388, 35308.29383412266, 47817.28274075822, 48018.75990620025, 48041.03917921552, 48364.758176208896, 48616.75691621519, 7182.317679820409, 7717.768466946, 8388.203120703523, 8438.324934005388, 8662.913370866463, 10858.619948301772, 12771.744565108831, 13245.668858278621, 13479.595612131652, 13498.52755153565, 11482.13883958723, 11697.473613687574, 11827.349495777815, 11834.230774999598, 11988.64034078979, 11346.319220846775, 11645.126615504041, 11708.121890858049, 11805.527778888749, 11960.521579137085, 11469.139814513777, 11700.824487632523, 11822.0, 12091.81862272049, 12189.451474683838, 7881.487703299267, 8050.872877796996, 8054.073781515201, 8131.2681858633005, 8150.877736834071, 8833.602487888189, 10844.295120817122, 10911.089460141335, 11539.596114135966, 11930.701732456759], "value": 8777.768530710016, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1361.6731984323765, 1529.3194528434847, 1546.2655238761588, 1731.2988239762892, 1869.093489657515, 8109.351251899849, 8371.455855369404, 8376.958115209416, 8381.958090209548, 8457.53483558404, 8173.754787356389, 8315.584220788967, 8324.0, 8339.74980750577, 8345.332373410129, 1989.1347263940231, 2277.453411181321, 2310.607196776544, 2332.475193081556, 2367.775061369176, 2200.6038912995655, 2213.2917466410754, 2214.6345852934246, 2215.601191785478, 2218.8779617121054, 2145.1205005947563, 2170.2295685031822, 2173.174193806359, 2176.3035828534876, 2176.3579743975565, 1898.8670793044491, 2224.5328481019005, 2279.726432828063, 2286.7713228677167, 2288.1762565476415, 2202.174184680745, 2204.8566843155304, 2210.9557808843733, 2211.9447013824624, 2267.319804058776, 8176.6320515576945, 8191.385646076568, 8264.256216940505, 8264.710735124241, 8283.37874659403, 5015.172496538067, 5208.088584497697, 5209.6874187548865, 5229.2417599448245, 5229.869253268661, 3578.3916734155255, 3589.174489867345, 3593.2633810069133, 3644.1982763791925, 3671.320805650963, 1125.4204084896285, 1146.358039497884, 1159.6636975277245, 1179.6637958181877, 1197.323512215604, 11643.883561164364, 11653.766924661459, 11660.708482287926, 11665.766684666343, 11667.824982625183, 4366.083122544238, 4477.552244775497, 4606.815727370935, 4639.466461356988, 4642.86071417858, 9746.269029822792, 9786.1192492676, 9788.608455661837, 9791.0, 9803.068708472683, 4704.200285951328, 5156.63903526757, 5198.506141916512, 5204.323437953042, 5204.713740744295, 4367.541408152162, 4397.032652816375, 4398.0, 4562.338460923148, 4644.512326205768, 3709.536307961505, 3790.3935370340614, 3813.523309586302, 3836.5204349456317, 3998.140399813996, 1254.7427777305631, 1262.7790136726037, 1263.6588121207224, 1265.981010284828, 1266.7262264235535, 1413.971720565583, 1417.7093695792337, 1441.128117488904, 1451.7314296855116, 1461.116024804999, 7928.088269848926, 7942.126366099725, 7942.920570794334, 7952.284294413531, 8010.118886922434, 468.641489260709, 480.274785074533, 482.2115840600573, 483.5309749543008, 486.0521982134851, 6163.322034576193, 6200.627962322275, 6201.0, 6243.032329988859, 6246.219222597176, 9836.311458198, 10257.692269231935, 10354.326968747007, 10376.16990640762, 10393.16854651626, 10091.798164036678, 10242.436665983294, 10259.076683098558, 10267.383956962607, 10292.691219263434, 7899.960500197462, 7916.050073991158, 7924.286814186866, 8005.319547838382, 8015.278624923785, 7656.425768067528, 7919.0893047298, 7925.841483170419, 7950.4832185907735, 7951.880721789294, 9533.30773565235, 9578.664746733832, 9601.567929443052, 9613.058949411612, 9720.562574684298, 9648.083432073941, 9716.562754675915, 9834.213262938805, 9834.75413114678, 9979.351342162736, 6850.9314906850295, 7234.240404757636, 7347.963260183665, 7418.0, 7486.850262994819, 7974.84050319002, 8111.9594402027615, 8155.9184408157535, 8158.551279679437, 8185.140560241089, 7060.576365418091, 7189.388901943394, 7299.5255308404785, 7332.890006650011, 7419.740309089156, 7334.6699398526125, 7355.485116041826, 7369.963150184215, 7376.446766492427, 7416.221296763762, 7702.114256860533, 7773.144954055162, 7785.883211751941, 7793.220677932161, 7793.571353575608, 6923.376896079377, 7075.71697132109, 7085.964570177116, 7165.426765858823, 7175.21072682015, 7064.646767661494, 7109.431245500451, 7110.25342339047, 7115.501914865909, 7115.644217789193], "value": 4700.028764532131, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.6478062814673, 342.21632461662784, 343.42990635545, 346.9809160496172, 354.8828886467466, 5613.550915926721, 5634.887302253953, 5649.180868774025, 5677.630953987988, 5691.4877661010505, 5568.136938774486, 5571.860703482415, 5593.356763972144, 5597.496225339719, 5599.664020158793, 4249.638780703636, 4287.056847493562, 4355.390245365651, 4363.803628836694, 4365.257906155961, 4317.481902171744, 4318.935215971763, 4335.43639326887, 4349.977260573833, 4352.673549483786, 4299.914001719963, 4309.612134907858, 4312.762798046107, 4313.266744653401, 4327.554931463728, 4053.310937140693, 4274.209271284792, 4274.316109422478, 4325.680667396443, 4327.242732521812, 3722.4788529605876, 3737.4767532545466, 3742.4947632069593, 3749.15643980105, 3759.293308817647, 5434.429384914567, 5440.510354068113, 5450.127979523258, 5467.195825377616, 5469.398366179717, 4812.350332705075, 4882.487338829407, 4945.184044632631, 4958.851234462972, 4993.825216117455, 5821.767129314822, 5875.882482350372, 5884.352721200665, 5895.557833162487, 5909.290885093773, 4176.227397931392, 4177.206330797169, 4187.8324867005285, 4188.497380314351, 4203.495580530325, 5871.178035075093, 6123.142760013601, 6173.259208894917, 6183.3816618337805, 6193.690315484253, 4243.511996120424, 4247.936280955788, 4263.765492897858, 4276.786160691953, 4282.5075116361395, 4315.611594956469, 4330.935035974463, 4334.718243314174, 4344.109457561192, 4350.195213885441, 4850.587700045465, 4963.528464795839, 4971.676841005323, 4985.302057711923, 4987.807803006079, 5938.61399009063, 5939.346671866091, 5950.256217972754, 5962.495751784174, 5970.462658360769, 1452.469848505309, 1462.8829693624484, 1465.3918623771015, 1465.7288401645517, 1468.1191285228776, 1002.9699109026741, 1011.4891979550428, 1012.8733908261468, 1022.7085280695115, 1029.0, 5608.018596745554, 5653.971730141323, 5746.367899531048, 5749.310082790092, 5750.856228594235, 6012.579119461596, 6024.337322894478, 6058.757649694051, 6066.514678825772, 6092.664903430265, 5499.367572729107, 5645.0, 5669.0, 5681.829545113653, 5737.110747834093, 3252.9590531030317, 3257.9674203257664, 3263.7062664360324, 3266.983665081659, 3267.6895694908944, 6132.478739307119, 6284.528660350492, 6290.622562646256, 6303.086052522359, 6404.135441715402, 6032.125341825411, 6217.7823776168525, 6345.809625711236, 6365.2679941806355, 6376.808695739135, 6123.693815309217, 6295.622262664163, 6340.682965851597, 6349.52378571609, 6353.7140828661895, 5778.422157784356, 6062.333143354139, 6085.726142323518, 6148.323684394623, 6154.661493617894, 5881.9705901470215, 6111.633302001894, 6113.724882380215, 6114.357992410733, 6122.357152498924, 6324.810255692337, 6327.778527751507, 6368.834596237301, 6374.0, 6376.52176086786, 4318.0, 4352.368906508602, 4417.867463976086, 4435.822567097409, 4438.312061630452, 6061.242344706911, 6087.482563982111, 6098.481629061579, 6099.329073801967, 6103.162029656231, 5722.914156287576, 5940.405959404198, 5969.134475500941, 5991.651878327341, 6013.098035294741, 6007.759689612367, 6016.819495415145, 6032.306284777132, 6037.969810150921, 6041.546883983807, 5859.20900678403, 5897.233359663216, 5933.406659334032, 5935.347111817783, 5937.970310148422, 5839.591228613956, 5982.162497250475, 5997.640141591519, 6019.398060193946, 6040.184575082308, 5808.970955145197, 5845.620034697731, 5875.471207591338, 5887.322957859901, 5895.9115613266695], "value": 4502.127482806949, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [777.9066512018559, 789.6959670526845, 818.6397984886653, 855.1875718067835, 886.4946980221273, 14226.288685565733, 14276.785848212285, 14289.928550357234, 14366.784498232535, 15204.08775473471, 14195.78706319406, 14228.430862765477, 14256.28718564073, 14259.572212833606, 14265.429382824701, 692.8718187135383, 825.3933358981144, 860.2300940658107, 861.1818772166467, 864.2308345572445, 833.954132522711, 839.9076101628816, 840.6637345061963, 840.8318336332727, 841.381584535366, 884.2925659472396, 888.0, 896.2829736211038, 897.9820403591924, 898.716904175186, 728.9198188199321, 855.3670283989834, 882.2236431939916, 883.4787475389487, 884.460479107747, 641.5861769158913, 645.9547831651786, 648.0311933659162, 650.6714109374735, 652.8988006858945, 13574.185548867, 13612.523561675294, 13636.318184090756, 13656.24890631015, 13679.726405471834, 13985.510507132201, 14215.289235538181, 14350.928245358811, 14440.422383104664, 14675.192864392455, 11671.12466565011, 11793.528258869635, 11820.88179118215, 11855.051595872395, 12069.456874440672, 3865.942010869839, 3902.0635047588376, 3966.246413181515, 4037.051292946155, 4053.695972802022, 56056.439435605935, 56487.0, 57889.13166302509, 58063.70968145132, 58218.417815821726, 11186.552537898393, 11229.775404491864, 11401.771964560663, 11491.678456977388, 11574.363410012531, 20497.897510512354, 20591.0, 20594.38216853497, 20608.69086963697, 20623.896880515502, 8521.701740439055, 8620.137986201455, 8672.089430609822, 8709.912900871037, 8978.955105224431, 4865.148598995162, 4866.31871537985, 4874.7562621868765, 4889.315495830587, 5087.389513258433, 3543.7165026797793, 3644.526211592476, 3660.8352624131444, 3661.9450708239397, 3663.3589121904092, 546.529984213576, 611.9020956646915, 645.3643161485933, 649.8895187818082, 653.7515744017243, 688.786476192382, 690.8169335126196, 705.340506626306, 736.443984791479, 745.9216782237895, 9310.72067837966, 9322.30082743797, 9369.250459963187, 9729.756756081013, 9784.168345690696, 597.4443767296369, 731.6890321613399, 732.6226993098559, 749.0973377080713, 772.9884051739228, 4418.80115394808, 4539.251023581072, 4539.6368290536675, 4553.180427523078, 4553.954460455419, 65049.0, 65224.67387663126, 65854.0, 65937.6703116491, 66279.33720662732, 59322.0, 59386.40613593895, 59910.70044649749, 60129.39870601326, 60461.39538604645, 52992.20511692328, 54076.45923540793, 54384.728076359366, 54769.45230547723, 56491.43508564862, 8709.782255443664, 8711.172438618321, 8853.15894989975, 8921.509316987627, 8984.32617553673, 34800.129996750285, 34846.825765871006, 35662.0, 35959.64040359563, 37129.443058354685, 44707.776461117486, 48803.75598121987, 49558.75220624018, 49780.502194977584, 50010.749946250035, 11820.468078936641, 12044.518219271482, 12062.155649104478, 12148.75702485963, 12170.087243456954, 13365.39855706476, 13679.31603419845, 13774.86225137776, 13926.791098133333, 13950.720985580434, 12809.487620495449, 12890.48438062467, 13074.542391016268, 13095.607131786062, 13593.45626174942, 12579.811302830647, 12580.559680411141, 12784.232946023269, 12875.227486350848, 13062.150960187557, 12279.815802762787, 12668.556600519307, 12701.237925724487, 12777.744445111231, 12997.415116319598, 10032.626019875532, 11041.503132358903, 11077.224594278323, 11324.150688698215, 11381.032612228053, 11139.220254582426, 11197.440127993405, 11488.942555287504, 11594.94202528982, 11622.302661840316], "value": 6962.72610710271, "unit": "score"}], "name": "dromaeo_css", "value": 7097.603160692088, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 112.0, 105.0, 110.0, 111.0, 110.0, 100.0, 111.0, 110.0, 109.0], "value": 108.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 128.0, 158.0, 177.0, 129.0, 161.0, 168.0, 124.0, 181.0, 127.0], "value": 151.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 161.0, 161.0, 160.0, 160.0, 162.0, 161.0, 162.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 76.0, 126.0, 111.0, 72.0, 73.0, 73.0, 124.0, 104.0, 72.0], "value": 90.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 143.0, 92.0, 93.0, 92.0, 154.0, 94.0, 93.0, 154.0], "value": 110.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 147.0, 146.0, 145.0, 145.0, 145.0, 147.0, 145.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 60.0, 59.0, 58.0, 58.0, 60.0, 78.0, 59.0, 56.0], "value": 60.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 63.0, 65.0, 64.0, 64.0, 64.0, 64.0, 64.0, 65.0], "value": 64.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 78.0, 78.0, 80.0, 83.0, 80.0, 79.0, 81.0, 81.0], "value": 79.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 129.0, 130.0, 133.0, 128.0, 129.0, 128.0, 129.0, 165.0, 132.0], "value": 133.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 164.0, 164.0, 164.0, 166.0, 167.0, 163.0, 164.0, 165.0, 163.0], "value": 165.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 68.0, 69.0, 68.0, 69.0, 71.0, 69.0, 68.0, 70.0], "value": 69.1, "unit": "score"}], "name": "kraken", "value": 1551.6, "alertThreshold": 2.0}]} 13:22:01 INFO - Return code: 0 13:22:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 13:22:01 ERROR - # TBPL SUCCESS # 13:22:01 INFO - Running post-action listener: _resource_record_post_action 13:22:01 INFO - Running post-run listener: _resource_record_post_run 13:22:02 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 540176384; Read time: 0; Write time: 359044 13:22:02 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 163893248; Read time: 0; Write time: 144604 13:22:02 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 290209792; Read time: 0; Write time: 154480 13:22:02 INFO - Running post-run listener: _upload_blobber_files 13:22:02 INFO - Blob upload gear active. 13:22:02 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 13:22:02 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:22:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 13:22:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 13:22:02 INFO - (blobuploader) - INFO - Open directory for files ... 13:22:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:22:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:22:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:22:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:22:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:22:03 INFO - (blobuploader) - INFO - Done attempting. 13:22:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 13:22:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:22:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:22:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:22:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:22:04 INFO - (blobuploader) - INFO - Done attempting. 13:22:04 INFO - (blobuploader) - INFO - Iteration through files over. 13:22:04 INFO - Return code: 0 13:22:04 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 13:22:04 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 13:22:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3d5110c5a018ee61692006179de00ee7dd6b837b82313edce26ff7d1a5d562c7d08e8fe9298ddeeaa8a4c20945b39adadb6b12e9676e871841cbaa0e3cb84653", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dc40897dae0080f214bb0309c227471706248101ed0d05cdf34bbc7b7b8d29b4300dabe14c3868ff1a380d5ee89065a989749b93e95cf7a88fee5efe3310a501"} 13:22:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 13:22:04 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 13:22:04 INFO - Contents: 13:22:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3d5110c5a018ee61692006179de00ee7dd6b837b82313edce26ff7d1a5d562c7d08e8fe9298ddeeaa8a4c20945b39adadb6b12e9676e871841cbaa0e3cb84653", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dc40897dae0080f214bb0309c227471706248101ed0d05cdf34bbc7b7b8d29b4300dabe14c3868ff1a380d5ee89065a989749b93e95cf7a88fee5efe3310a501"} 13:22:04 INFO - Running post-run listener: copy_logs_to_upload_dir 13:22:04 INFO - Copying logs to upload dir... 13:22:04 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 13:22:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.522763 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-04-08 13:22:03.766423) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-08 13:22:03.769655) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1460144889.796129-1899462580 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3d5110c5a018ee61692006179de00ee7dd6b837b82313edce26ff7d1a5d562c7d08e8fe9298ddeeaa8a4c20945b39adadb6b12e9676e871841cbaa0e3cb84653", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dc40897dae0080f214bb0309c227471706248101ed0d05cdf34bbc7b7b8d29b4300dabe14c3868ff1a380d5ee89065a989749b93e95cf7a88fee5efe3310a501"} build_url:https://queue.taskcluster.net/v1/task/ANRvAcnGTIO10nxB5YdV9Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011166 build_url: 'https://queue.taskcluster.net/v1/task/ANRvAcnGTIO10nxB5YdV9Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3d5110c5a018ee61692006179de00ee7dd6b837b82313edce26ff7d1a5d562c7d08e8fe9298ddeeaa8a4c20945b39adadb6b12e9676e871841cbaa0e3cb84653", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dc40897dae0080f214bb0309c227471706248101ed0d05cdf34bbc7b7b8d29b4300dabe14c3868ff1a380d5ee89065a989749b93e95cf7a88fee5efe3310a501"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-08 13:22:03.795152) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 13:22:03.795544) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1460144889.796129-1899462580 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004431 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 13:22:03.879653) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-08 13:22:03.880013) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-08 13:22:03.880357) ========= ========= Total master_lag: 0.42 =========