builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-057 starttime: 1453323539.82 results: success (0) buildid: 20160120103206 builduid: 0ed4dee76eff4cd0a1364d8961c7d418 revision: b8dfc7fb1398fbc20994ba73fee89a1a9fe9935c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-20 12:58:59.823805) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-20 12:58:59.824393) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-20 12:58:59.824735) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1453323539.114316-265268296 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006211 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-20 12:58:59.848946) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-20 12:58:59.849630) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-20 12:58:59.882855) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 12:58:59.883580) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1453323539.114316-265268296 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021859 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 12:58:59.934220) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-20 12:58:59.934584) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-20 12:58:59.935039) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 12:58:59.935351) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1453323539.114316-265268296 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-20 12:58:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 218M=0s 2016-01-20 12:59:00 (218 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.154300 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 12:59:00.106473) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 12:59:00.107252) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1453323539.114316-265268296 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.070579 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 12:59:00.192474) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 12:59:00.193336) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev b8dfc7fb1398fbc20994ba73fee89a1a9fe9935c --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 b8dfc7fb1398fbc20994ba73fee89a1a9fe9935c --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=934fc3100db09dcb9af4d4b6000001ab-1453323539.114316-265268296 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-20 12:59:00,290 truncating revision to first 12 chars 2016-01-20 12:59:00,290 Setting DEBUG logging. 2016-01-20 12:59:00,290 attempt 1/10 2016-01-20 12:59:00,290 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/b8dfc7fb1398?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-20 12:59:00,555 unpacking tar archive at: mozilla-inbound-b8dfc7fb1398/testing/mozharness/ program finished with exit code 0 elapsedTime=0.551012 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 12:59:00.759299) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-20 12:59:00.759717) ========= echo b8dfc7fb1398fbc20994ba73fee89a1a9fe9935c in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'b8dfc7fb1398fbc20994ba73fee89a1a9fe9935c'] 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=934fc3100db09dcb9af4d4b6000001ab-1453323539.114316-265268296 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False b8dfc7fb1398fbc20994ba73fee89a1a9fe9935c program finished with exit code 0 elapsedTime=0.004734 script_repo_revision: 'b8dfc7fb1398fbc20994ba73fee89a1a9fe9935c' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-20 12:59:00.810683) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-20 12:59:00.811031) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-20 12:59:00.820871) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-20 12:59:00.821163) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/b8dfc7fb1398fbc20994ba73fee89a1a9fe9935c ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-20 12:59:00.821582) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-01-20 12:59:00.821943) ========= /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=934fc3100db09dcb9af4d4b6000001ab-1453323539.114316-265268296 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:59:01 INFO - MultiFileLogger online at 20160120 12:59:01 in /builds/slave/test-pgo 12:59:01 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 12:59:01 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 12:59:01 INFO - {'append_to_log': False, 12:59:01 INFO - 'base_work_dir': '/builds/slave/test-pgo', 12:59:01 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 12:59:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 12:59:01 INFO - 'branch': 'Mozilla-Inbound', 12:59:01 INFO - 'buildbot_json_path': 'buildprops.json', 12:59:01 INFO - 'config_files': ('talos/linux_config.py',), 12:59:01 INFO - 'default_actions': ('clobber', 12:59:01 INFO - 'read-buildbot-config', 12:59:01 INFO - 'download-and-extract', 12:59:01 INFO - 'populate-webroot', 12:59:01 INFO - 'create-virtualenv', 12:59:01 INFO - 'install', 12:59:01 INFO - 'run-tests'), 12:59:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:59:01 INFO - 'download_minidump_stackwalk': True, 12:59:01 INFO - 'download_symbols': 'ondemand', 12:59:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:59:01 INFO - 'tooltool.py': '/tools/tooltool.py', 12:59:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:59:01 INFO - '/tools/misc-python/virtualenv.py')}, 12:59:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:59:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:59:01 INFO - 'installer_path': 'installer.exe', 12:59:01 INFO - 'log_level': 'info', 12:59:01 INFO - 'log_name': 'talos', 12:59:01 INFO - 'log_to_console': True, 12:59:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:59:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:59:01 INFO - 'opt_config_files': (), 12:59:01 INFO - 'pip_index': False, 12:59:01 INFO - 'sps_profile': False, 12:59:01 INFO - 'sps_profile_interval': 0, 12:59:01 INFO - 'suite': 'dromaeojs', 12:59:01 INFO - 'system_bits': '32', 12:59:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:59:01 INFO - 'title': 'talos-linux64-ix-057', 12:59:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:59:01 INFO - 'use_talos_json': True, 12:59:01 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 12:59:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:59:01 INFO - 'work_dir': 'build'} 12:59:01 INFO - ##### 12:59:01 INFO - ##### Running clobber step. 12:59:01 INFO - ##### 12:59:01 INFO - Running pre-action listener: _resource_record_pre_action 12:59:01 INFO - Running main action method: clobber 12:59:01 INFO - rmtree: /builds/slave/test-pgo/build 12:59:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 12:59:02 INFO - Running post-action listener: _resource_record_post_action 12:59:02 INFO - ##### 12:59:02 INFO - ##### Running read-buildbot-config step. 12:59:02 INFO - ##### 12:59:02 INFO - Running pre-action listener: _resource_record_pre_action 12:59:02 INFO - Running main action method: read_buildbot_config 12:59:02 INFO - Using buildbot properties: 12:59:02 INFO - { 12:59:02 INFO - "project": "", 12:59:02 INFO - "product": "firefox", 12:59:02 INFO - "script_repo_revision": "production", 12:59:02 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 12:59:02 INFO - "repository": "", 12:59:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 12:59:02 INFO - "buildid": "20160120103206", 12:59:02 INFO - "pgo_build": "True", 12:59:02 INFO - "basedir": "/builds/slave/test-pgo", 12:59:02 INFO - "buildnumber": 624, 12:59:02 INFO - "slavename": "talos-linux64-ix-057", 12:59:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:59:02 INFO - "platform": "ubuntu64_hw", 12:59:02 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 12:59:02 INFO - "branch": "mozilla-inbound", 12:59:02 INFO - "repo_path": "integration/mozilla-inbound", 12:59:02 INFO - "revision": "b8dfc7fb1398fbc20994ba73fee89a1a9fe9935c", 12:59:02 INFO - "stage_platform": "linux64-pgo", 12:59:02 INFO - "builduid": "0ed4dee76eff4cd0a1364d8961c7d418", 12:59:02 INFO - "slavebuilddir": "test" 12:59:02 INFO - } 12:59:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/IWIs2hUYT7C2NB0uDV2DcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 12:59:02 INFO - Running post-action listener: _resource_record_post_action 12:59:02 INFO - ##### 12:59:02 INFO - ##### Running download-and-extract step. 12:59:02 INFO - ##### 12:59:02 INFO - Running pre-action listener: _resource_record_pre_action 12:59:02 INFO - Running main action method: download_and_extract 12:59:02 INFO - mkdir: /builds/slave/test-pgo/build/tests 12:59: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')]} 12:59:02 INFO - https://queue.taskcluster.net/v1/task/IWIs2hUYT7C2NB0uDV2DcQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:59:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWIs2hUYT7C2NB0uDV2DcQ/artifacts/public/build/test_packages.json 12:59:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWIs2hUYT7C2NB0uDV2DcQ/artifacts/public/build/test_packages.json 12:59:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWIs2hUYT7C2NB0uDV2DcQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 12:59:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWIs2hUYT7C2NB0uDV2DcQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 12:59:03 INFO - Downloaded 1448 bytes. 12:59:03 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 12:59:03 INFO - Using the following test package requirements: 12:59:03 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 12:59:03 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:59:03 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:59:03 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:59:03 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:59:03 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:59:03 INFO - u'jsshell-linux-x86_64.zip'], 12:59:03 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:59:03 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:59:03 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 12:59:03 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:59:03 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:59:03 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:59:03 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:59:03 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:59:03 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:59:03 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 12:59:03 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:59:03 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:59:03 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:59:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:03 INFO - https://queue.taskcluster.net/v1/task/IWIs2hUYT7C2NB0uDV2DcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:59:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWIs2hUYT7C2NB0uDV2DcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:59:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWIs2hUYT7C2NB0uDV2DcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:59:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWIs2hUYT7C2NB0uDV2DcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:59:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWIs2hUYT7C2NB0uDV2DcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:59:04 INFO - Downloaded 22486924 bytes. 12:59:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 12:59:04 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 12:59:05 INFO - Return code: 0 12:59:05 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:59: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')]} 12:59:05 INFO - https://queue.taskcluster.net/v1/task/IWIs2hUYT7C2NB0uDV2DcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:59:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWIs2hUYT7C2NB0uDV2DcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:59:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWIs2hUYT7C2NB0uDV2DcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:59:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWIs2hUYT7C2NB0uDV2DcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:59:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWIs2hUYT7C2NB0uDV2DcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:59:06 INFO - Downloaded 22486924 bytes. 12:59:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 12:59:06 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 12:59:07 INFO - Return code: 0 12:59:07 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')]} 12:59:07 INFO - https://queue.taskcluster.net/v1/task/IWIs2hUYT7C2NB0uDV2DcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:59:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWIs2hUYT7C2NB0uDV2DcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 12:59:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWIs2hUYT7C2NB0uDV2DcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 12:59:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWIs2hUYT7C2NB0uDV2DcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 12:59:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWIs2hUYT7C2NB0uDV2DcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:59:08 INFO - Downloaded 10705515 bytes. 12:59:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 12:59:08 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 12:59:08 INFO - Return code: 0 12:59: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')]} 12:59:08 INFO - https://queue.taskcluster.net/v1/task/IWIs2hUYT7C2NB0uDV2DcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:59:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWIs2hUYT7C2NB0uDV2DcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 12:59:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWIs2hUYT7C2NB0uDV2DcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 12:59:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWIs2hUYT7C2NB0uDV2DcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 12:59:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWIs2hUYT7C2NB0uDV2DcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:59:10 INFO - Downloaded 55946692 bytes. 12:59:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IWIs2hUYT7C2NB0uDV2DcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 12:59:10 INFO - mkdir: /builds/slave/test-pgo/properties 12:59:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 12:59:10 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 12:59:10 INFO - Contents: 12:59:10 INFO - build_url:https://queue.taskcluster.net/v1/task/IWIs2hUYT7C2NB0uDV2DcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 12:59:10 INFO - Running post-action listener: _resource_record_post_action 12:59:10 INFO - Running post-action listener: set_extra_try_arguments 12:59:10 INFO - ##### 12:59:10 INFO - ##### Running populate-webroot step. 12:59:10 INFO - ##### 12:59:10 INFO - Running pre-action listener: _resource_record_pre_action 12:59:10 INFO - Running main action method: populate_webroot 12:59:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:59:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:59:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:59:10 INFO - '--tppagecycles', 12:59:10 INFO - '7'], 12:59:10 INFO - 'tests': ['tsvgm']}}, 12:59:10 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:59:10 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:59:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:59:10 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:59:10 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:59:10 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:59:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:59:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:59:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:59:10 INFO - 'talos_options': ['--e10s'], 12:59:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:59:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:59:10 INFO - 'tests': ['damp', 'tps']}, 12:59:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:59:10 INFO - 'talos_options': ['--e10s'], 12:59:10 INFO - 'tests': ['damp', 'tps']}, 12:59:10 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:59:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:59:10 INFO - 'other': {'tests': ['a11yr', 12:59:10 INFO - 'ts_paint', 12:59:10 INFO - 'tpaint', 12:59:10 INFO - 'sessionrestore', 12:59:10 INFO - 'sessionrestore_no_auto_restore']}, 12:59:10 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:59:10 INFO - 'tests': ['a11yr', 12:59:10 INFO - 'ts_paint', 12:59:10 INFO - 'tpaint', 12:59:10 INFO - 'sessionrestore', 12:59:10 INFO - 'sessionrestore_no_auto_restore']}, 12:59:10 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:59:10 INFO - 'tests': ['a11yr', 12:59:10 INFO - 'ts_paint', 12:59:10 INFO - 'tpaint', 12:59:10 INFO - 'sessionrestore', 12:59:10 INFO - 'sessionrestore_no_auto_restore']}, 12:59:10 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:59:10 INFO - 'tests': ['a11yr', 12:59:10 INFO - 'ts_paint', 12:59:10 INFO - 'tpaint', 12:59:10 INFO - 'sessionrestore', 12:59:10 INFO - 'sessionrestore_no_auto_restore']}, 12:59:10 INFO - 'other_l64': {'tests': ['a11yr', 12:59:10 INFO - 'ts_paint', 12:59:10 INFO - 'tpaint', 12:59:10 INFO - 'sessionrestore', 12:59:10 INFO - 'sessionrestore_no_auto_restore']}, 12:59:10 INFO - 'other_nol64': {'tests': ['a11yr', 12:59:10 INFO - 'ts_paint', 12:59:10 INFO - 'tpaint', 12:59:10 INFO - 'sessionrestore', 12:59:10 INFO - 'sessionrestore_no_auto_restore']}, 12:59:10 INFO - 'svgr': {'tests': ['tsvgx', 12:59:10 INFO - 'tsvgr_opacity', 12:59:10 INFO - 'tart', 12:59:10 INFO - 'tscrollx', 12:59:10 INFO - 'cart']}, 12:59:10 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:59:10 INFO - 'tests': ['tsvgx', 12:59:10 INFO - 'tsvgr_opacity', 12:59:10 INFO - 'tart', 12:59:10 INFO - 'tscrollx', 12:59:10 INFO - 'cart']}, 12:59:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:59:10 INFO - 'tests': ['tp5o']}, 12:59:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:59:10 INFO - 'talos_options': ['--e10s'], 12:59:10 INFO - 'tests': ['tp5o']}, 12:59:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:59:10 INFO - 'talos_options': ['--xperf_path', 12:59:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:59:10 INFO - 'tests': ['tp5n']}, 12:59:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:59:10 INFO - 'talos_options': ['--e10s', 12:59:10 INFO - '--xperf_path', 12:59:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:59:10 INFO - 'tests': ['tp5n']}}, 12:59:10 INFO - 'talos.zip': {'path': '', 12:59:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:59:10 INFO - Running post-action listener: _resource_record_post_action 12:59:10 INFO - ##### 12:59:10 INFO - ##### Running create-virtualenv step. 12:59:10 INFO - ##### 12:59:10 INFO - Running pre-action listener: _resource_record_pre_action 12:59:10 INFO - Running main action method: create_virtualenv 12:59:10 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 12:59:10 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 12:59:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 12:59:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:59:10 INFO - Using real prefix '/usr' 12:59:10 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 12:59:10 INFO - Installing distribute.............................................................................................................................................................................................done. 12:59:13 INFO - Installing pip.................done. 12:59:13 INFO - Return code: 0 12:59:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 12:59:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:59:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:59:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:13 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 0x7f815ac31f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a06230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a987f0>, '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 0x2a042d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a04760>, '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': '934fc3100db09dcb9af4d4b6000001ab-1453323539.114316-265268296', '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 12:59:13 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 12:59:13 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 12:59:13 INFO - Using env: {'DISPLAY': ':0', 12:59:13 INFO - 'HOME': '/home/cltbld', 12:59:13 INFO - 'LANG': 'en_US.UTF-8', 12:59:13 INFO - 'LANGUAGE': 'en_US:en', 12:59:13 INFO - 'LOGNAME': 'cltbld', 12:59:13 INFO - 'MAIL': '/var/mail/cltbld', 12:59:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:59:13 INFO - 'MOZ_NO_REMOTE': '1', 12:59:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:59:13 INFO - 'NO_EM_RESTART': '1', 12:59:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:59:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:59:13 INFO - 'PWD': '/builds/slave/test-pgo', 12:59:13 INFO - 'SHELL': '/bin/bash', 12:59:13 INFO - 'SHLVL': '1', 12:59:13 INFO - 'TERM': 'linux', 12:59:13 INFO - 'TMOUT': '86400', 12:59:13 INFO - 'USER': 'cltbld', 12:59:13 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1453323539.114316-265268296', 12:59:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:59:13 INFO - '_': '/tools/buildbot/bin/python'} 12:59:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:59:13 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 12:59:13 INFO - Cleaning up... 12:59:13 INFO - Return code: 0 12:59:13 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 12:59:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:59:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:59:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:13 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 0x7f815ac31f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a06230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a987f0>, '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 0x2a042d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a04760>, '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': '934fc3100db09dcb9af4d4b6000001ab-1453323539.114316-265268296', '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 12:59:13 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 12:59:13 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 12:59:13 INFO - Using env: {'DISPLAY': ':0', 12:59:13 INFO - 'HOME': '/home/cltbld', 12:59:13 INFO - 'LANG': 'en_US.UTF-8', 12:59:13 INFO - 'LANGUAGE': 'en_US:en', 12:59:13 INFO - 'LOGNAME': 'cltbld', 12:59:13 INFO - 'MAIL': '/var/mail/cltbld', 12:59:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:59:13 INFO - 'MOZ_NO_REMOTE': '1', 12:59:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:59:13 INFO - 'NO_EM_RESTART': '1', 12:59:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:59:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:59:13 INFO - 'PWD': '/builds/slave/test-pgo', 12:59:13 INFO - 'SHELL': '/bin/bash', 12:59:13 INFO - 'SHLVL': '1', 12:59:13 INFO - 'TERM': 'linux', 12:59:13 INFO - 'TMOUT': '86400', 12:59:13 INFO - 'USER': 'cltbld', 12:59:13 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1453323539.114316-265268296', 12:59:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:59:13 INFO - '_': '/tools/buildbot/bin/python'} 12:59:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:59:13 INFO - Downloading/unpacking psutil>=0.7.1 12:59:13 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 12:59:13 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 12:59:13 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 12:59:13 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 12:59:13 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 12:59:13 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 12:59:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 12:59:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:59:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:59:15 INFO - Installing collected packages: psutil 12:59:15 INFO - Running setup.py install for psutil 12:59:15 INFO - building 'psutil._psutil_linux' extension 12:59:15 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 12:59:15 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 12:59:15 INFO - building 'psutil._psutil_posix' extension 12:59:15 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 12:59:15 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 12:59:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:59:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:59:15 INFO - Successfully installed psutil 12:59:15 INFO - Cleaning up... 12:59:15 INFO - Return code: 0 12:59:15 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 12:59:15 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')]} 12:59:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:59:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:15 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')]} 12:59:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:59:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:15 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 0x7f815ac31f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a06230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a987f0>, '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 0x2a042d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a04760>, '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': '934fc3100db09dcb9af4d4b6000001ab-1453323539.114316-265268296', '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 12:59:15 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 12:59:15 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 12:59:15 INFO - Using env: {'DISPLAY': ':0', 12:59:15 INFO - 'HOME': '/home/cltbld', 12:59:15 INFO - 'LANG': 'en_US.UTF-8', 12:59:15 INFO - 'LANGUAGE': 'en_US:en', 12:59:15 INFO - 'LOGNAME': 'cltbld', 12:59:15 INFO - 'MAIL': '/var/mail/cltbld', 12:59:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:59:15 INFO - 'MOZ_NO_REMOTE': '1', 12:59:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:59:15 INFO - 'NO_EM_RESTART': '1', 12:59:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:59:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:59:15 INFO - 'PWD': '/builds/slave/test-pgo', 12:59:15 INFO - 'SHELL': '/bin/bash', 12:59:15 INFO - 'SHLVL': '1', 12:59:15 INFO - 'TERM': 'linux', 12:59:15 INFO - 'TMOUT': '86400', 12:59:15 INFO - 'USER': 'cltbld', 12:59:15 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1453323539.114316-265268296', 12:59:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:59:15 INFO - '_': '/tools/buildbot/bin/python'} 12:59:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:59:16 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:59:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:59:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:59:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:59:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:59:17 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:59:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:59:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:59:17 INFO - Installing collected packages: mozsystemmonitor 12:59:17 INFO - Running setup.py install for mozsystemmonitor 12:59:18 INFO - Successfully installed mozsystemmonitor 12:59:18 INFO - Cleaning up... 12:59:18 INFO - Return code: 0 12:59:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 12:59: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')]} 12:59:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:59:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59: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')]} 12:59:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:59:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:18 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 0x7f815ac31f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a06230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a987f0>, '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 0x2a042d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a04760>, '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': '934fc3100db09dcb9af4d4b6000001ab-1453323539.114316-265268296', '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 12:59:18 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 12:59:18 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 12:59:18 INFO - Using env: {'DISPLAY': ':0', 12:59:18 INFO - 'HOME': '/home/cltbld', 12:59:18 INFO - 'LANG': 'en_US.UTF-8', 12:59:18 INFO - 'LANGUAGE': 'en_US:en', 12:59:18 INFO - 'LOGNAME': 'cltbld', 12:59:18 INFO - 'MAIL': '/var/mail/cltbld', 12:59:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:59:18 INFO - 'MOZ_NO_REMOTE': '1', 12:59:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:59:18 INFO - 'NO_EM_RESTART': '1', 12:59:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:59:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:59:18 INFO - 'PWD': '/builds/slave/test-pgo', 12:59:18 INFO - 'SHELL': '/bin/bash', 12:59:18 INFO - 'SHLVL': '1', 12:59:18 INFO - 'TERM': 'linux', 12:59:18 INFO - 'TMOUT': '86400', 12:59:18 INFO - 'USER': 'cltbld', 12:59:18 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1453323539.114316-265268296', 12:59:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:59:18 INFO - '_': '/tools/buildbot/bin/python'} 12:59:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:59:18 INFO - Downloading/unpacking blobuploader==1.2.4 12:59:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:59:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:59:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:59:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:59:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:59:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:59:20 INFO - Downloading blobuploader-1.2.4.tar.gz 12:59:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:59:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:59:20 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 12:59:20 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 12:59:20 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 12:59:20 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 12:59:20 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 12:59:20 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 12:59:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 12:59:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:59:21 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 12:59:21 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 12:59:21 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 12:59:21 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 12:59:21 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 12:59:21 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 12:59:21 INFO - Downloading docopt-0.6.1.tar.gz 12:59:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 12:59:21 INFO - Installing collected packages: blobuploader, requests, docopt 12:59:21 INFO - Running setup.py install for blobuploader 12:59:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:59:21 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 12:59:21 INFO - Running setup.py install for requests 12:59:21 INFO - Running setup.py install for docopt 12:59:21 INFO - Successfully installed blobuploader requests docopt 12:59:21 INFO - Cleaning up... 12:59:21 INFO - Return code: 0 12:59:21 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:59:21 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')]} 12:59:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:59:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:21 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')]} 12:59:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:59:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:21 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 0x7f815ac31f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a06230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a987f0>, '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 0x2a042d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a04760>, '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': '934fc3100db09dcb9af4d4b6000001ab-1453323539.114316-265268296', '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 12:59:21 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 12:59:21 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 12:59:21 INFO - Using env: {'DISPLAY': ':0', 12:59:21 INFO - 'HOME': '/home/cltbld', 12:59:21 INFO - 'LANG': 'en_US.UTF-8', 12:59:21 INFO - 'LANGUAGE': 'en_US:en', 12:59:21 INFO - 'LOGNAME': 'cltbld', 12:59:21 INFO - 'MAIL': '/var/mail/cltbld', 12:59:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:59:21 INFO - 'MOZ_NO_REMOTE': '1', 12:59:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:59:21 INFO - 'NO_EM_RESTART': '1', 12:59:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:59:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:59:21 INFO - 'PWD': '/builds/slave/test-pgo', 12:59:21 INFO - 'SHELL': '/bin/bash', 12:59:21 INFO - 'SHLVL': '1', 12:59:21 INFO - 'TERM': 'linux', 12:59:21 INFO - 'TMOUT': '86400', 12:59:21 INFO - 'USER': 'cltbld', 12:59:21 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1453323539.114316-265268296', 12:59:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:59:21 INFO - '_': '/tools/buildbot/bin/python'} 12:59:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:59:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:59:22 INFO - Running setup.py (path:/tmp/pip-BrAIR9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:59:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:59:22 INFO - Running setup.py (path:/tmp/pip-XQ621z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:59:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:59:22 INFO - Running setup.py (path:/tmp/pip-PDtKiC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:59:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:59:22 INFO - Running setup.py (path:/tmp/pip-L9jlqC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:59:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:59:22 INFO - Running setup.py (path:/tmp/pip-dlfUWy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:59:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:59:22 INFO - Running setup.py (path:/tmp/pip-pZaQ5k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:59:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:59:22 INFO - Running setup.py (path:/tmp/pip-EQsheq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:59:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:59:22 INFO - Running setup.py (path:/tmp/pip-a_fPlU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:59:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:59:22 INFO - Running setup.py (path:/tmp/pip-etc1y7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:59:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:59:22 INFO - Running setup.py (path:/tmp/pip-N8696I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:59:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:59:22 INFO - Running setup.py (path:/tmp/pip-JMa38i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:59:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:59:23 INFO - Running setup.py (path:/tmp/pip-pFs8T3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:59:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:59:23 INFO - Running setup.py (path:/tmp/pip-_V4vyP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:59:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:59:23 INFO - Running setup.py (path:/tmp/pip-Z3W8cD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:59:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:59:23 INFO - Running setup.py (path:/tmp/pip-ZJh5ve-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:59:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:59:23 INFO - Running setup.py (path:/tmp/pip-hbNO6O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:59:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:59:23 INFO - Running setup.py (path:/tmp/pip-d4aVw4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:59:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:59:23 INFO - Running setup.py install for manifestparser 12:59:23 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 12:59:23 INFO - Running setup.py install for mozcrash 12:59:23 INFO - Running setup.py install for mozdebug 12:59:23 INFO - Running setup.py install for mozdevice 12:59:23 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 12:59:23 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 12:59:23 INFO - Running setup.py install for mozfile 12:59:23 INFO - Running setup.py install for mozhttpd 12:59:24 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 12:59:24 INFO - Running setup.py install for mozinfo 12:59:24 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 12:59:24 INFO - Running setup.py install for mozInstall 12:59:24 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 12:59:24 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 12:59:24 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 12:59:24 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 12:59:24 INFO - Running setup.py install for mozleak 12:59:24 INFO - Running setup.py install for mozlog 12:59:24 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 12:59:24 INFO - Running setup.py install for moznetwork 12:59:24 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 12:59:24 INFO - Running setup.py install for mozprocess 12:59:24 INFO - Running setup.py install for mozprofile 12:59:24 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 12:59:24 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 12:59:24 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 12:59:24 INFO - Running setup.py install for mozrunner 12:59:24 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 12:59:24 INFO - Running setup.py install for mozscreenshot 12:59:25 INFO - Running setup.py install for moztest 12:59:25 INFO - Running setup.py install for mozversion 12:59:25 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 12:59:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:59:25 INFO - Cleaning up... 12:59:25 INFO - Return code: 0 12:59:25 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:59:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:59:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:59:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:25 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 0x7f815ac31f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a06230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a987f0>, '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 0x2a042d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a04760>, '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': '934fc3100db09dcb9af4d4b6000001ab-1453323539.114316-265268296', '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 12:59:25 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 12:59:25 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 12:59:25 INFO - Using env: {'DISPLAY': ':0', 12:59:25 INFO - 'HOME': '/home/cltbld', 12:59:25 INFO - 'LANG': 'en_US.UTF-8', 12:59:25 INFO - 'LANGUAGE': 'en_US:en', 12:59:25 INFO - 'LOGNAME': 'cltbld', 12:59:25 INFO - 'MAIL': '/var/mail/cltbld', 12:59:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:59:25 INFO - 'MOZ_NO_REMOTE': '1', 12:59:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:59:25 INFO - 'NO_EM_RESTART': '1', 12:59:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:59:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:59:25 INFO - 'PWD': '/builds/slave/test-pgo', 12:59:25 INFO - 'SHELL': '/bin/bash', 12:59:25 INFO - 'SHLVL': '1', 12:59:25 INFO - 'TERM': 'linux', 12:59:25 INFO - 'TMOUT': '86400', 12:59:25 INFO - 'USER': 'cltbld', 12:59:25 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1453323539.114316-265268296', 12:59:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:59:25 INFO - '_': '/tools/buildbot/bin/python'} 12:59:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:59:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:59:25 INFO - Running setup.py (path:/tmp/pip-RUywYT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:59:25 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)) 12:59:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:59:25 INFO - Running setup.py (path:/tmp/pip-P4PyIX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:59:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 12:59:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:59:25 INFO - Running setup.py (path:/tmp/pip-VWUdfm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:59:25 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)) 12:59:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:59:25 INFO - Running setup.py (path:/tmp/pip-zm2r3q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:59:25 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)) 12:59:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:59:25 INFO - Running setup.py (path:/tmp/pip-IJvbPn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:59:25 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)) 12:59:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:59:25 INFO - Running setup.py (path:/tmp/pip-S1gfrP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:59:25 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)) 12:59:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:59:25 INFO - Running setup.py (path:/tmp/pip-m8A4oh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:59:25 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)) 12:59:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:59:25 INFO - Running setup.py (path:/tmp/pip-wBfR4U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:59:26 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)) 12:59:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:59:26 INFO - Running setup.py (path:/tmp/pip-UayZ7M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:59:26 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)) 12:59:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:59:26 INFO - Running setup.py (path:/tmp/pip-tQWnam-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:59:26 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)) 12:59:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:59:26 INFO - Running setup.py (path:/tmp/pip-Yoa9Fu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:59:26 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)) 12:59:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:59:26 INFO - Running setup.py (path:/tmp/pip-zRKlml-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:59:26 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)) 12:59:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:59:26 INFO - Running setup.py (path:/tmp/pip-MI_ryD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:59:26 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)) 12:59:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:59:26 INFO - Running setup.py (path:/tmp/pip-O1lg1l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:59:26 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)) 12:59:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:59:26 INFO - Running setup.py (path:/tmp/pip-I0uA23-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:59:26 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)) 12:59:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:59:26 INFO - Running setup.py (path:/tmp/pip-if7NLh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:59:26 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)) 12:59:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:59:26 INFO - Running setup.py (path:/tmp/pip-ad7jXh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:59:26 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)) 12:59:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 12:59:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 12:59:26 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)) 12:59:26 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)) 12:59:26 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)) 12:59:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 12:59:26 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 12:59:26 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 12:59:26 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 12:59:26 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 12:59:26 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 12:59:26 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 12:59:28 INFO - Downloading blessings-1.6.tar.gz 12:59:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 12:59:28 INFO - Installing collected packages: blessings 12:59:28 INFO - Running setup.py install for blessings 12:59:28 INFO - Successfully installed blessings 12:59:28 INFO - Cleaning up... 12:59:28 INFO - Return code: 0 12:59:28 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 12:59:28 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:59:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:59:28 INFO - Reading from file tmpfile_stdout 12:59:28 INFO - Current package versions: 12:59:28 INFO - argparse == 1.2.1 12:59:28 INFO - blessings == 1.6 12:59:28 INFO - blobuploader == 1.2.4 12:59:28 INFO - docopt == 0.6.1 12:59:28 INFO - manifestparser == 1.1 12:59:28 INFO - mozInstall == 1.12 12:59:28 INFO - mozcrash == 0.16 12:59:28 INFO - mozdebug == 0.1 12:59:28 INFO - mozdevice == 0.48 12:59:28 INFO - mozfile == 1.2 12:59:28 INFO - mozhttpd == 0.7 12:59:28 INFO - mozinfo == 0.9 12:59:28 INFO - mozleak == 0.1 12:59:28 INFO - mozlog == 3.1 12:59:28 INFO - moznetwork == 0.27 12:59:28 INFO - mozprocess == 0.22 12:59:28 INFO - mozprofile == 0.28 12:59:28 INFO - mozrunner == 6.11 12:59:28 INFO - mozscreenshot == 0.1 12:59:28 INFO - mozsystemmonitor == 0.0 12:59:28 INFO - moztest == 0.7 12:59:28 INFO - mozversion == 1.4 12:59:28 INFO - psutil == 3.1.1 12:59:28 INFO - requests == 1.2.3 12:59:28 INFO - wsgiref == 0.1.2 12:59:28 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:59: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')]} 12:59:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:59:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59: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')]} 12:59:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:59:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:28 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 0x7f815ac31f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a06230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a987f0>, '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 0x2a042d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a04760>, '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': '934fc3100db09dcb9af4d4b6000001ab-1453323539.114316-265268296', '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 12:59:28 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 12:59:28 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 12:59:28 INFO - Using env: {'DISPLAY': ':0', 12:59:28 INFO - 'HOME': '/home/cltbld', 12:59:28 INFO - 'LANG': 'en_US.UTF-8', 12:59:28 INFO - 'LANGUAGE': 'en_US:en', 12:59:28 INFO - 'LOGNAME': 'cltbld', 12:59:28 INFO - 'MAIL': '/var/mail/cltbld', 12:59:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:59:28 INFO - 'MOZ_NO_REMOTE': '1', 12:59:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:59:28 INFO - 'NO_EM_RESTART': '1', 12:59:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:59:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:59:28 INFO - 'PWD': '/builds/slave/test-pgo', 12:59:28 INFO - 'SHELL': '/bin/bash', 12:59:28 INFO - 'SHLVL': '1', 12:59:28 INFO - 'TERM': 'linux', 12:59:28 INFO - 'TMOUT': '86400', 12:59:28 INFO - 'USER': 'cltbld', 12:59:28 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1453323539.114316-265268296', 12:59:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:59:28 INFO - '_': '/tools/buildbot/bin/python'} 12:59:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:59:29 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)) 12:59:29 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)) 12:59:29 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)) 12:59:29 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)) 12:59:29 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)) 12:59:29 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)) 12:59:29 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)) 12:59:29 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)) 12:59:29 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)) 12:59:29 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)) 12:59:29 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)) 12:59:29 INFO - Cleaning up... 12:59:29 INFO - Return code: 0 12:59:29 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 12:59:29 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')]} 12:59:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:59:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:29 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')]} 12:59:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:59:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:29 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 0x7f815ac31f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a06230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a987f0>, '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 0x2a042d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a04760>, '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': '934fc3100db09dcb9af4d4b6000001ab-1453323539.114316-265268296', '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 12:59:29 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 12:59:29 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 12:59:29 INFO - Using env: {'DISPLAY': ':0', 12:59:29 INFO - 'HOME': '/home/cltbld', 12:59:29 INFO - 'LANG': 'en_US.UTF-8', 12:59:29 INFO - 'LANGUAGE': 'en_US:en', 12:59:29 INFO - 'LOGNAME': 'cltbld', 12:59:29 INFO - 'MAIL': '/var/mail/cltbld', 12:59:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:59:29 INFO - 'MOZ_NO_REMOTE': '1', 12:59:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:59:29 INFO - 'NO_EM_RESTART': '1', 12:59:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:59:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:59:29 INFO - 'PWD': '/builds/slave/test-pgo', 12:59:29 INFO - 'SHELL': '/bin/bash', 12:59:29 INFO - 'SHLVL': '1', 12:59:29 INFO - 'TERM': 'linux', 12:59:29 INFO - 'TMOUT': '86400', 12:59:29 INFO - 'USER': 'cltbld', 12:59:29 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1453323539.114316-265268296', 12:59:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:59:29 INFO - '_': '/tools/buildbot/bin/python'} 12:59:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:59:29 INFO - Downloading/unpacking jsonschema 12:59:29 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 12:59:29 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 12:59:29 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 12:59:29 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 12:59:29 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 12:59:29 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 12:59:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:59:31 INFO - Downloading/unpacking functools32 (from jsonschema) 12:59:31 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 12:59:31 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 12:59:31 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 12:59:31 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 12:59:31 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 12:59:31 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 12:59:31 INFO - Downloading functools32-3.2.3-2.tar.gz 12:59:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 12:59:31 INFO - warning: no files found matching '*.txt' 12:59:31 INFO - no previously-included directories found matching 'build' 12:59:31 INFO - no previously-included directories found matching 'dist' 12:59:31 INFO - no previously-included directories found matching '.git*' 12:59:31 INFO - Installing collected packages: jsonschema, functools32 12:59:31 INFO - Running setup.py install for functools32 12:59:31 INFO - warning: no files found matching '*.txt' 12:59:31 INFO - no previously-included directories found matching 'build' 12:59:31 INFO - no previously-included directories found matching 'dist' 12:59:31 INFO - no previously-included directories found matching '.git*' 12:59:31 INFO - Successfully installed jsonschema functools32 12:59:31 INFO - Cleaning up... 12:59:31 INFO - Return code: 0 12:59:31 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 12:59:31 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')]} 12:59:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:59:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:31 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')]} 12:59:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:59:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:31 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 0x7f815ac31f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a06230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a987f0>, '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 0x2a042d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a04760>, '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': '934fc3100db09dcb9af4d4b6000001ab-1453323539.114316-265268296', '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 12:59:31 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 12:59:31 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 12:59:31 INFO - Using env: {'DISPLAY': ':0', 12:59:31 INFO - 'HOME': '/home/cltbld', 12:59:31 INFO - 'LANG': 'en_US.UTF-8', 12:59:31 INFO - 'LANGUAGE': 'en_US:en', 12:59:31 INFO - 'LOGNAME': 'cltbld', 12:59:31 INFO - 'MAIL': '/var/mail/cltbld', 12:59:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:59:31 INFO - 'MOZ_NO_REMOTE': '1', 12:59:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:59:31 INFO - 'NO_EM_RESTART': '1', 12:59:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:59:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:59:31 INFO - 'PWD': '/builds/slave/test-pgo', 12:59:31 INFO - 'SHELL': '/bin/bash', 12:59:31 INFO - 'SHLVL': '1', 12:59:31 INFO - 'TERM': 'linux', 12:59:31 INFO - 'TMOUT': '86400', 12:59:31 INFO - 'USER': 'cltbld', 12:59:31 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1453323539.114316-265268296', 12:59:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:59:31 INFO - '_': '/tools/buildbot/bin/python'} 12:59:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:59:31 INFO - Downloading/unpacking flake8 12:59:31 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 12:59:31 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 12:59:31 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 12:59:31 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 12:59:31 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 12:59:31 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 12:59:33 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:59:33 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:59:33 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 12:59:33 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 12:59:33 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 12:59:33 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 12:59:33 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 12:59:33 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 12:59:33 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:59:33 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:59:33 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 12:59:33 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 12:59:33 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 12:59:33 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 12:59:33 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 12:59:33 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 12:59:33 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:59:33 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 12:59:33 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 12:59:33 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 12:59:33 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 12:59:33 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 12:59:33 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 12:59:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 12:59:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:59:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:59:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:59:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:59:34 INFO - no previously-included directories found matching 'docs/_build' 12:59:34 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:59:34 INFO - Running setup.py install for pep8 12:59:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:59:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:59:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:59:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:59:34 INFO - no previously-included directories found matching 'docs/_build' 12:59:34 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 12:59:34 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:59:34 INFO - Cleaning up... 12:59:34 INFO - Return code: 0 12:59:34 INFO - Running post-action listener: _resource_record_post_action 12:59:34 INFO - Running post-action listener: _start_resource_monitoring 12:59:34 INFO - Starting resource monitoring. 12:59:34 INFO - ##### 12:59:34 INFO - ##### Running install step. 12:59:34 INFO - ##### 12:59:34 INFO - Running pre-action listener: _resource_record_pre_action 12:59:34 INFO - Running main action method: install 12:59:34 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:59:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:59:34 INFO - Reading from file tmpfile_stdout 12:59:34 INFO - Detecting whether we're running mozinstall >=1.0... 12:59:34 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 12:59:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 12:59:34 INFO - Reading from file tmpfile_stdout 12:59:34 INFO - Output received: 12:59:34 INFO - Usage: mozinstall [options] installer 12:59:34 INFO - Options: 12:59:34 INFO - -h, --help show this help message and exit 12:59:34 INFO - -d DEST, --destination=DEST 12:59:34 INFO - Directory to install application into. [default: 12:59:34 INFO - "/builds/slave/test-pgo"] 12:59:34 INFO - --app=APP Application being installed. [default: firefox] 12:59:34 INFO - mkdir: /builds/slave/test-pgo/build/application 12:59:34 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 12:59:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 12:59:50 INFO - Reading from file tmpfile_stdout 12:59:50 INFO - Output received: 12:59:50 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 12:59:50 INFO - Running post-action listener: _resource_record_post_action 12:59:50 INFO - ##### 12:59:50 INFO - ##### Running run-tests step. 12:59:50 INFO - ##### 12:59:50 INFO - Running pre-action listener: _resource_record_pre_action 12:59:50 INFO - Running main action method: run_tests 12:59:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 12:59:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 12:59:50 INFO - Python 2.7.3 12:59:50 INFO - Return code: 0 12:59:50 INFO - grabbing minidump binary from tooltool 12:59:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:50 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 0x2a987f0>, '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 0x2a042d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a04760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 12:59:50 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 12:59:50 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 12:59:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:59:50 INFO - Return code: 0 12:59:50 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 12:59:50 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 12:59:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 12:59:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 12:59:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 12:59:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 12:59:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 12:59:51 INFO - Return code: 0 12:59:51 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/IWIs2hUYT7C2NB0uDV2DcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 12:59:51 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/IWIs2hUYT7C2NB0uDV2DcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --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 12:59:51 INFO - Using env: {'DISPLAY': ':0', 12:59:51 INFO - 'HOME': '/home/cltbld', 12:59:51 INFO - 'LANG': 'en_US.UTF-8', 12:59:51 INFO - 'LANGUAGE': 'en_US:en', 12:59:51 INFO - 'LOGNAME': 'cltbld', 12:59:51 INFO - 'MAIL': '/var/mail/cltbld', 12:59:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:59:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 12:59:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:59:51 INFO - 'MOZ_NO_REMOTE': '1', 12:59:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:59:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:59:51 INFO - 'NO_EM_RESTART': '1', 12:59:51 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:59:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:59:51 INFO - 'PWD': '/builds/slave/test-pgo', 12:59:51 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 12:59:51 INFO - 'SHELL': '/bin/bash', 12:59:51 INFO - 'SHLVL': '1', 12:59:51 INFO - 'TERM': 'linux', 12:59:51 INFO - 'TMOUT': '86400', 12:59:51 INFO - 'USER': 'cltbld', 12:59:51 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1453323539.114316-265268296', 12:59:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:59:51 INFO - '_': '/tools/buildbot/bin/python'} 12:59:51 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/IWIs2hUYT7C2NB0uDV2DcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 12:59:51 INFO - mozversion application_buildid: 20160120103206 12:59:51 INFO - mozversion application_changeset: b8dfc7fb1398fbc20994ba73fee89a1a9fe9935c 12:59:51 INFO - mozversion application_display_name: Nightly 12:59:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:59:51 INFO - mozversion application_name: Firefox 12:59:51 INFO - mozversion application_remotingname: firefox 12:59:51 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 12:59:51 INFO - mozversion application_vendor: Mozilla 12:59:51 INFO - mozversion application_version: 46.0a1 12:59:51 INFO - mozversion platform_buildid: 20160120103206 12:59:51 INFO - mozversion platform_changeset: b8dfc7fb1398fbc20994ba73fee89a1a9fe9935c 12:59:51 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 12:59:51 INFO - mozversion platform_version: 46.0a1 12:59:51 INFO - using testdate: 1453323591 12:59:51 INFO - actual date: 1453323591 12:59:51 INFO - starting webserver on 'localhost:45868' 12:59:51 INFO - SUITE-START | Running 3 tests 12:59:51 INFO - TEST-START | dromaeo_css 12:59:51 INFO - operating with platform_type : linux_ 12:59:51 INFO - Initialising browser for dromaeo_css test... 12:59:51 INFO - TEST-INFO | started process 23518 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYQgYL9/profile http://localhost:45868/getInfo.html) 12:59:56 INFO - PROCESS | 23518 | __metrics Screen width/height:1600/1200 12:59:56 INFO - PROCESS | 23518 | colorDepth:24 12:59:56 INFO - PROCESS | 23518 | Browser inner width/height: 1024/697 12:59:56 INFO - PROCESS | 23518 | __metrics 12:59:56 INFO - PROCESS | 23518 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 12:59:56 INFO - PROCESS | 23518 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:59:57 INFO - TEST-INFO | 23518: exit 0 12:59:57 INFO - Browser initialized. 12:59:57 INFO - Running cycle 1/1 for dromaeo_css test... 12:59:57 INFO - TEST-INFO | started process 23609 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYQgYL9/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:00:09 INFO - PROCESS | 23609 | RSS: Main: 148992000 13:00:09 INFO - PROCESS | 23609 | 13:01:00 INFO - PROCESS | 23609 | 1453323660702 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:03:08 INFO - PROCESS | 23609 | Cycle 1(1): loaded http://localhost:45868/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45868/tests/dromaeo/cssquery-ext.html) 13:03:10 INFO - PROCESS | 23609 | RSS: Main: 226779136 13:03:10 INFO - PROCESS | 23609 | 13:06:12 INFO - PROCESS | 23609 | Cycle 1(1): loaded http://localhost:45868/tests/dromaeo/cssquery-ext.html (next: http://localhost:45868/tests/dromaeo/cssquery-jquery.html) 13:06:13 INFO - PROCESS | 23609 | RSS: Main: 225984512 13:06:13 INFO - PROCESS | 23609 | 13:09:15 INFO - PROCESS | 23609 | Cycle 1(1): loaded http://localhost:45868/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45868/tests/dromaeo/cssquery-mootools.html) 13:09:15 INFO - PROCESS | 23609 | RSS: Main: 236630016 13:09:15 INFO - PROCESS | 23609 | 13:12:17 INFO - PROCESS | 23609 | Cycle 1(1): loaded http://localhost:45868/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45868/tests/dromaeo/cssquery-prototype.html) 13:12:17 INFO - PROCESS | 23609 | RSS: Main: 208343040 13:12:17 INFO - PROCESS | 23609 | 13:15:20 INFO - PROCESS | 23609 | Cycle 1(1): loaded http://localhost:45868/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45868/tests/dromaeo/cssquery-yui.html) 13:15:21 INFO - PROCESS | 23609 | RSS: Main: 210382848 13:15:21 INFO - PROCESS | 23609 | 13:18:23 INFO - PROCESS | 23609 | Cycle 1(1): loaded http://localhost:45868/tests/dromaeo/cssquery-yui.html (next: http://localhost:45868/tests/dromaeo/cssquery-dojo.html) 13:18:24 INFO - PROCESS | 23609 | RSS: Main: 267563008 13:18:24 INFO - PROCESS | 23609 | 13:18:24 INFO - PROCESS | 23609 | __start_tp_report 13:18:24 INFO - PROCESS | 23609 | _x_x_mozilla_page_load 13:18:24 INFO - PROCESS | 23609 | _x_x_mozilla_page_load_details 13:18:24 INFO - PROCESS | 23609 | |i|pagename|runs| 13:18:24 INFO - PROCESS | 23609 | |0;dojo.html;3063.172943305306;3066.3407367416003;3115.2834847984964;3117.423276693813;3147.669494703056;4990.251462280659;5082.4917508249155;5144.562712169465;5146.176611742122;5164.173732202848;5024.0454313680375;5115.667481613693;5150.1244788385975;5228.241904923793;5235.319408476893;4605.148047611186;4623.884402889929;4643.489216186217;4659.790309436066;4696.483386827446;4420.446567816783;4753.952460475385;4800.3279540864305;4843.467218605951;4855.975720121412;4592.425946756655;4659.161350956826;4665.230237010889;4787.281907713854;4834.661573689843;4695.859124226278;4722.858314250578;4725.787339569728;4726.7400292983875;4730.62155027597;4680.695754775963;4692.085043416535;4695.577398034194;4697.765111744399;4698.201305778026;4906.754662266872;4976.4277108132665;4988.376452943382;4995.8501244962345;5007.474215207387;5571.025070612667;5571.13647384656;5578.581606379537;5592.496675299202;5597.132444471114;5411.702356370398;5418.566514678816;5613.326400831886;5684.033714268584;5685.061964775807;5098.133317336062;5154.716490593016;5196.818111366084;5197.272381866504;5239.502247286502;5569.192467092249;5603.075492543766;5606.074997625346;5619.887602247933;5663.773449062074;5268.841934741964;5351.625386223005;5401.108817045222;5401.729913504388;5402.51377376038;5368.677879327252;5403.243545903577;5408.3509978802795;5419.918701219406;5459.344878614592;5414.3232095988005;5447.809326673548;5456.863578410492;5464.098423760114;5509;5308.309919710413;5410.431904650034;5414.485623865727;5446.591505637093;5480.534154596904;4291.077418355068;4312.741235525878;4317.589828966243;4342.478902531717;4371.322445020964;3807.8286477108595;3855.306044911943;3873.1479074603544;3884.378499440076;3890.7860067696547;4957.504249575086;5037.19404895215;5104.69371837691;5116.283720279164;5120.539151476385;5516.200150978086;5537.197106419547;5558.360788509292;5569.832905012856;5574.749136288877;5140.948590514122;5151.536361727388;5154.407243167008;5172;5217.556507696889;4566.70316429431;4659.65052621048;4746.098241334135;4760.357351757469;4824.131656301899;5552.3892371839065;5558.471945165203;5558.999999999919;5559.444055594408;5563.13771365439;5343.732813359395;5392.838214853561;5404.8108316208745;5424;5446.455354464521;5575.163725441216;5671.744771485375;5672.376038635829;5694.1458781183155;5738.885222295614;5432.429594892479;5463.207834863843;5476.91784623239;5479;5479.287692599936;5493.807716729895;5530.281063461724;5539.307586551681;5548.029094908295;5595.132754423071;5230.163173892159;5320.388155362183;5331.09371406854;5361.4370491099435;5469.070258056219;5361.24942508057;5391.002664507078;5391.272178255886;5397.487238712316;5397.865053373697;5275.076861549291;5295.602829787705;5303.003941959242;5303.708296043755;5367.597430192673;5291.417944026077;5343.3587969443915;5363.758630861543;5403.324584426947;5435.592330575302;5185.559227465707;5213.582913366846;5214.165733482625;5214.921776173436;5261.921071183859 13:18:24 INFO - PROCESS | 23609 | |1;ext.html;517.984460466186;556.5825630776917;577.9797707080252;581.9844371571609;593.8574742061903;27889.721102788964;28347.716522834766;28372.290692732666;35361.46957795629;36336;39326.21347573047;39524.407133893015;39611.60388396115;39637.40543891844;39769.80115099427;8341.708040218578;8542.14578542147;8547.444416112963;8550.40147189697;8554.61504232308;8261.669533218665;8371.288440482565;8385.62264698087;8390.874136887951;8397.076321604618;8296.045954715195;8309.459885107479;8344.165583441669;8358.164183581654;8366.53984030878;8473.95763021184;8523.872141917876;8553.786155346135;8558.400911936167;8560.657573697044;8309.626066826946;8444.451110677786;8457.323414126917;8459.492430454193;8460.111688272766;39169;39673.404898926536;39686.40470392947;39735.8013209935;39804;3110.322513307596;3143.984280078585;3469.7224222062173;3590;3854.7494412863075;29136.854315728287;29349.11952641424;29555.852220738758;30013.24966875824;30513.694863051307;3850.268448994682;3930.1353702185475;3978;3993.0416699991792;4019.376996565537;202137;202282;202420;202905;203892;50291;50836.23745643818;51040.48959510357;53518;55273.72363138159;51569.2264616031;51838.48161518412;51859.48140518622;51878.74060629673;52124.47875521272;12555.183913045623;12704.301263430416;12715.682107947376;12730.80903786444;12733.426995785212;8794.120587941283;8866.955665221632;10039.297249192487;10218.386896786216;10224.437655928847;17859.553511162067;17885.28458861657;17995.190216440293;18027.369042083465;18043.909780451013;6873.503591380726;7197.244289349543;7237.529560578546;7268.491205615662;7310.4151667866445;927.0451435021938;965.2133511188359;976.2287792643874;1007.7077647482295;1119.7256672115384;25264.36839079001;28448.43103137967;30247;30564.38871222563;31019.68980310213;1007.9848802267971;1012.0790081026231;1022.7954409118206;1034.9546957572754;1041.1670663469195;14737;15244;15414.845851541566;15500.984871966572;16164.595885102732;314877;318937;319569;319720;320769;50580.747096264284;50743.91073071255;50775.746121269156;50830.74584627053;50844.74577627088;1319.577735124751;1327;1344.9125806822526;1345.1861623717705;1349.4399824073096;27476.45047099087;28410.495673325695;28415.289617758895;28533.28666783264;28920;43743.56256437395;44121;44128.33807492955;44143.77928110339;44166.55833441753;293697;296176;296658;296824;296954;26680.332991675365;30675;31157.065288041395;31302.373952520367;31314.060578182693;37756.81121594484;38277.61722382741;38618;38806.6119338803;38940;33968.66031339655;34269.657303427644;34324.313513730085;34721;35616.28767424689;28640.42719145647;32414.189645258113;32936.835315824224;33251.83374083114;34076.82961585176;33937;34039.48940765841;35070.64929350776;35674.64325356817;35690.286194275446;27257.827399872822;30891.083171760773;30947.990224740533;31234.68765312409;31341.52987705232;22897.771022289562;23510.882445588348;23919.282421527383;24181;24195.15316963898 13:18:24 INFO - PROCESS | 23609 | |2;jquery.html;363.79445613228523;364.2823637434254;364.32054218881785;364.9616790237025;367.49652975423675;13494.527691530799;13514.594562163125;15583.922080389597;16739.916300418496;17923;15550;16049.518514444557;16441.588960276;16459.25933333;16740.246688899;5151.896962060757;5567.582431317647;5569.10894256919;5571.721413929307;5578.748956296977;4002.4996875390575;4178.498580170369;5427.538659213971;5526.751296191661;5798.246227990356;5745.482906538432;5911.645301281916;5971.761129554812;5975.551833612496;5983.940160598382;5914.083317085859;5929.644221346733;5937.970310148465;5950.166976623254;5970.164177015221;5148.91872706732;5258.895631917302;5262.05283049051;5339.225812257239;5364.946350536523;19351.709724354147;19580.70628940567;19807.7028844566;19810.70283945742;19829.702554461695;2198.8240940724863;2226.4100013496436;2291.5302363015544;2336.0422226886894;2350.753170917046;12290.754184916252;12530.122891397607;12665.683357916034;12669.429875655618;12733.36333183337;1793.560577658469;1817.9181936812874;1847.4642353717406;1855.8793678410996;1945.7956914523913;51067.744661276825;55175.44824551743;55854;58957.705211474095;60767;14650.63373415673;14702.779458308134;14865.466032860082;14919.477818276308;14982.550523484095;22409.767462789376;22418.32745017652;22515.761633110007;22680.16497937758;22711.205107821148;7775.844483110306;7912.762617121495;8252;8304.377171712025;8326.45878017927;6852.314768523208;6856.280090590416;6865.9313406866295;6891.414229790424;6900;7705.113911900091;7708.38332933364;7709.768706938801;7711.190325015793;7771.805704857424;2704.337437327867;3068;3068.8772449102235;3078.26121730783;3081.2604974805886;454.7362529732747;462.8588280574457;889.5374405309203;913.0096389870014;955.7132860141929;9908.455034973145;10482.947585262025;10567.418791966516;10678.145748340114;10796.622118225981;443.6096235312904;444.34237328753625;444.517698297351;453.9773011349419;458.0381199481063;5766.971165144231;5890.911636325459;6136.8772624548155;6162;6225.750969961241;334641;335258;484437;493842;503887;61659.76680466365;62584.687076565235;64544.354556453836;64581.35418645848;65123.674381628734;493.87899964508927;500.36703569984;503.1999121396996;503.52920019781624;504.20587574569464;8711.085336039878;9873.950630246803;10031.498425078862;10049.799004019733;10282.691519254435;29864.850675746482;30111.289983901555;30594.541081883344;30781.38437231198;31099.378012440076;35295;35311.470327945615;35464;35995.46006809847;37659.62340376561;6996.335348141918;7024.016637670628;7042.542234754725;7065.0815393998455;7159.856802863809;10231.94884025575;10702.143828493858;10805.513751881026;11253.324800511995;11358.716032099264;8521.744347669579;8853.380263381501;9420.576074076545;9518.143367096995;9587.520623968912;8985;9367.391119577205;9560.569774360032;9860.06329398706;10046.648367307109;9571.1864491519;9851.763741591185;10017.749556261151;10133.847992280269;10342.37945723259;7423.1834498206235;7427.071616047994;7434.888476672746;7450.552966822008;7479.513831600929;8516.276116529916;9580.281478888972;9716.805663886824;9763.511824408894;9984.35101718386 13:18:24 INFO - PROCESS | 23609 | |3;mootools.html;1217.7442737025224;1442.1563385419533;1450.7171101635179;1567.5983116636896;1762.3038899634653;6774.729010839566;6949.548279361838;7414.703411863519;7490.101187857451;7536.208698086704;7567.545947243169;7590.468667193299;7646.502977306485;7651.732189373373;7654.081510218782;1978.8317992970542;2028.8072633099905;2252.155441709355;2276.169198242646;2277.5900337939165;2258.2660635293514;2311.133325003124;2311.780380863815;2312.8034117100065;2313.9471540449053;2214.1143542583013;2230.119102954332;2265.546890621874;2267.6258417361114;2270.2054281001683;2209.5470428562107;2224.699665545155;2232.1964092926614;2272.091163534583;2280.0309868305903;2250.8762018089;2263.3888850010403;2283.4177284792436;2286.6112760830697;2290.6907567478343;7638.197989211164;7657.770266892002;7663;7664.885026724603;7670.348020418215;4638.420197475316;4712.976435117836;4744.264638980963;4764.857054288377;4778.665493415462;2970.569267456207;3027.697230276977;3062.494688376415;3076.2001879511263;3112.6264848218357;946.8437707778209;970.3741086998916;985.5269470654055;1004.4324956399611;1019.4749703902496;10498.107660848837;10557.894421055767;10587.258891877571;10592.15262778976;10603.363798172135;4146.108586653884;4210.705250632487;4270.295401258758;4312.202242585132;4313.41768861206;8629.741107766777;8664.8700269496;8670.306375489945;8679.479231246145;8684.175003374668;4686.882827929329;4709.552592503706;4727.976360118178;4733.668643194943;4733.692309999839;4365.257906155897;4378.10248898975;4399.340098985178;4407.493138289074;4407.867763967086;3228.870845166167;3274.099622603803;3281.45855933773;3412.112850658797;3501.5447991760907;1017.9338343007829;1025.6564051042835;1073.4257172412879;1075.166745772033;1078.2075174746556;1014.5181039006413;1020.3316827477865;1061.2412125330272;1092.1317552545745;1097.3964319624174;7106.502544821917;7128.750493732695;7142.678579463936;7154.570725756471;7159.284071592799;1096.2326371539955;1097.4074000040048;1107.4850194659361;1129.4465711801158;1134.3647557367901;5533;5594.300712410949;5627.8593035174445;5639.661620302795;5666.036773748473;8890.59992300348;9243.722688319362;9257.444553326823;9326.90673093274;9370.812583748288;8929.73210803677;8943.508107054175;9042;9050.637974481078;9067.501287429255;6788.660566971632;7032.156141263081;7071.964640176869;7077.398421134261;7126.536775109601;6893.965530172317;6940.479464040318;6949.895751563832;6983.930160698531;7022.12223472066;8017.879731804144;8171.182881711781;8194.22154895284;8201;8301.958490207511;8321.791955200926;8325.791855203668;8339.416240863082;8356.122607126164;8471.830563388821;6727.8990815138795;6977.406920411822;6993.440524757905;6995.720171193096;6995.755148569776;7322.63386830667;7373.262673732584;7380;7380.261973802577;7387.076615423072;5728.684922329312;6760.594364338155;6838.7264509419065;6872.793816185523;7008.544444611084;6615.17310336208;6649.700763465559;6714;6737.056812046416;6904.067950826574;6859.794206173823;6923.93076069253;6947.23580406165;6995.615241161785;6999.615021173884;6062.393760624079;6108.053251745987;6109.389061093855;6111.7249723763425;6211.0372892201785;6538.084668146368;6557.868842623217;6592.24189218246;6596.142501474777;6602.702878370581 13:18:24 INFO - PROCESS | 23609 | |4;prototype.html;335.50010484378276;338.9949150762739;344.85171376308176;350.2190116041228;353.14186526740025;5773.826785196446;5823.3012038555435;5825.854353641161;5832.445917637818;5857.033589457739;5693.202951586781;5748.051571490699;5761.971190144054;5764.221830052941;5768.134779783035;4502.23462011458;4505.639548836085;4507.684462087655;4508.72947623142;4513.819447222108;4298.763568003758;4453.4433195850515;4475.664325175609;4478.776061196927;4480.484744254403;4418.513963464016;4425.402570652969;4425.645948324142;4427.800748966304;4428.867133985986;4220.641245494121;4300.075483770973;4361.476622805252;4404.4494438195225;4437.755923424211;3886.0479182600443;3911.2764138634443;3911.5697273299916;3915.11909820291;3918.0400801803457;5424.864378390533;5432;5459.181122831567;5461;5468.7539060742365;4816.301636262722;4988.251762235657;4990.575801056914;5005.874853128665;5085.618578606583;6009.128676341906;6013.639181649071;6054.122152287938;6064.4541991221;6075.210222671025;4297.462817147856;4303.33298338758;4305.117450922553;4306.676999225039;4308.9138217235795;6243.2508099027955;6276.372362763733;6345.904811427832;6348.682565871688;6367.872642547123;4378.562143785596;4386.385905973167;4391.824327026947;4395.296752519582;4397.780110994501;4441.045175287329;4446.73319600825;4449.421575195204;4449.665100469846;4458.621017213573;5101.2603172539775;5105.642605017613;5107.668001579886;5110.744462776846;5117.437081920985;5962.403759624003;6117.694115294306;6122.051082082285;6128.908066379008;6133.723982420802;1558.688262347535;1577.7081239970641;1578.8263291037977;1580.5100418870188;1581.667849751565;1061.124572227915;1061.3525749292926;1062.0388548363744;1075.6988043347876;1078.4230436716318;5777.94222057774;5785.971070144707;5789.507891829157;5795.391483894215;5801.53587712982;6328.873422531524;6333.904991425133;6341.8097457076365;6349.777757778548;6352.618842869442;5826.067829147316;5829.154772557956;5830.941690583039;5836.562257830679;5839.678817664984;3322.202671358905;3400.3369342978376;3408.693217610427;3410.3349846780134;3413.35146322198;6513.478921686254;6520.250171230275;6520.641364724986;6524.021396790519;6527.184101987252;6333.1766870306565;6480.4815614750705;6482.254540727877;6495.837604059841;6503.154589903283;6442.967785161044;6546.443552298013;6590.439812615886;6602.537822352389;6617.272100068989;6367.52243581724;6387.329330420424;6389.968050159905;6393.360663933569;6398.936010639834;6118.541109416722;6271.059341098871;6291.465225455888;6319.3364696706185;6323.20959880015;6573.638449885302;6574.8356291093105;6580.934190658224;6592.604443733391;6593.274739778524;4398.230309695854;4400.405945197357;4400.669949753846;4402.097569998079;4402.911941761083;6173;6372.776952806629;6381.680915954091;6382.5532212744665;6393.520485963479;6160.537959652955;6170;6218.689065546614;6224;6228.5951413158;6180.47465965398;6196.845078872884;6198.442140207223;6201.844953876189;6208.844778880383;5909.409059094228;6091.878162436815;6093.725782339717;6097.2988106366565;6101.084837274267;6240.126382306572;6242.438180563589;6250.281217660027;6250.718717657807;6254.437100660963;6090.786822461193;6103.908441373294;6104.694765261808;6107.9389206109145;6110.297315808739 13:18:24 INFO - PROCESS | 23609 | |5;yui.html;672.3780503034693;709.6380845768656;834.1116710703103;845.1801752300266;849.2314455417845;12691.492340306388;12838.679033024178;12867.292298923556;12877.356132193376;12885.935570322135;12737.745245095093;12756;12786.296753678544;12803.359832008386;12822.358882055907;639.3223183425583;645.2225068792094;646.2148489585153;773.8452309538087;789.3685051958439;782.3858271257064;784.3725019984018;785.2187073861487;785.3795501553766;785.7564155111905;822.2065706593137;826.9917300826975;829.1749709039514;830.3315830756238;830.4602008694336;672.9158855143107;814.7067055859916;816.7835523586255;817.6034623207739;821.8315245374683;503.4135232454187;596.8030549918517;604.1059232336123;617.6170774120075;618.4650277509967;12856;13006.544770932973;13079.86920130796;13101.08292419531;13134.60596182116;12021.819672704916;12416.875831241663;12421.689457763538;12527.937360313232;12712.682182945407;9991.10080092788;10028.699139025768;10306.948465257701;10308;10499.580016799318;3557.48416479609;3564.7682900611635;3565.447355659877;3597.334493118781;3693.076730817296;47710.76144619255;47867;48504.514954850354;48725.51274487281;50085.49914500845;10231.386116833013;10333.638322658671;10370.740731481774;10465.68602941913;10839.86181450952;18269;18301.7254741179;18317.267309307746;18327.450176494727;18335.90832045858;7466.328030477283;7502.137254215835;7543.094828620491;7588.241175882478;7744.806379840436;4120.606522964007;4134.524529679125;4161.417401563784;4188.560201178893;4228.703990720682;3022.410629927143;3056.2053865995003;3057.5260834570677;3069.1252992896916;3069.355435358555;540.9594280428984;549.1022178737712;550.7686771555956;554.2268535393104;555.6194007105146;628.446966669328;659.8086554899025;685.6434653980002;687.9621620810904;716.1728203924475;8021.2379823916635;8306.252437280673;8412.705555305658;8487.405881588229;8521.147885211429;478.57645983305025;619.8667286533417;668.9397954184146;675.3246753246754;715.6171448275148;3729.5572397287488;3853.3641949078087;3959.7822119783687;4074.246264441088;4278.593533614302;58274.70862645745;59361.40638593559;61157.38842611517;62604;62733;49696.50303496991;50560;50599.74700126476;50673.74663126661;50845.74577127165;45612.77193614077;45926;46006;47438;48338.75830620895;8206.58967051633;8528.147185281423;8602.870956935776;8988.370814042953;9169;34457.138571535914;34460;35797.82101089478;36142;36187.81906090453;46984.53015469802;47397.630118493245;47613.28580071371;47771.761141194074;47929;10723.892761072602;11212.383318917538;11358.60244891425;11370.68389618393;11480.081593472669;12083.57707480234;12199.512019519474;12639.241645501299;12675;12980.870191297967;11247.66257012291;11404.771904562029;11517.884821152016;11725.824112638487;12192.57325993586;11650.53397864076;11845.111616628616;12089.939550302544;12360.134790564574;12372.505099796268;11206.271592346471;11214;11237.269577477438;11407.942960285145;11636.825447618123;9818.312718109664;9829.31194816356;9869.555869985725;9994.500274986367;10167.7458063549;9658.909468305766;10147.847782283125;10226.233032522441;10277.075063244343;10290.897091028994 13:18:24 INFO - PROCESS | 23609 | __end_tp_report 13:18:24 INFO - PROCESS | 23609 | __start_cc_report 13:18:24 INFO - PROCESS | 23609 | _x_x_mozilla_cycle_collect,917 13:18:24 INFO - PROCESS | 23609 | __end_cc_report 13:18:24 INFO - PROCESS | 23609 | __startTimestamp1453324704083__endTimestamp 13:18:24 INFO - PROCESS | 23609 | 13:18:24 INFO - PROCESS | 23609 | ------- Summary: start ------- 13:18:24 INFO - PROCESS | 23609 | Number of tests: 6 13:18:24 INFO - PROCESS | 23609 | 13:18:24 INFO - PROCESS | 23609 | [#0] dojo.html Cycles:165 Average:5102.02 Median:5275.08 stddev:545.00 (10.3%) stddev-sans-first:522.68 13:18:24 INFO - PROCESS | 23609 | Values: 3063.2 3066.3 3115.3 3117.4 3147.7 4990.3 5082.5 5144.6 5146.2 5164.2 5024.0 5115.7 5150.1 5228.2 5235.3 4605.1 4623.9 4643.5 4659.8 4696.5 4420.4 4754.0 4800.3 4843.5 4856.0 4592.4 4659.2 4665.2 4787.3 4834.7 4695.9 4722.9 4725.8 4726.7 4730.6 4680.7 4692.1 4695.6 4697.8 4698.2 4906.8 4976.4 4988.4 4995.9 5007.5 5571.0 5571.1 5578.6 5592.5 5597.1 5411.7 5418.6 5613.3 5684.0 5685.1 5098.1 5154.7 5196.8 5197.3 5239.5 5569.2 5603.1 5606.1 5619.9 5663.8 5268.8 5351.6 5401.1 5401.7 5402.5 5368.7 5403.2 5408.4 5419.9 5459.3 5414.3 5447.8 5456.9 5464.1 5509.0 5308.3 5410.4 5414.5 5446.6 5480.5 4291.1 4312.7 4317.6 4342.5 4371.3 3807.8 3855.3 3873.1 3884.4 3890.8 4957.5 5037.2 5104.7 5116.3 5120.5 5516.2 5537.2 5558.4 5569.8 5574.7 5140.9 5151.5 5154.4 5172.0 5217.6 4566.7 4659.7 4746.1 4760.4 4824.1 5552.4 5558.5 5559.0 5559.4 5563.1 5343.7 5392.8 5404.8 5424.0 5446.5 5575.2 5671.7 5672.4 5694.1 5738.9 5432.4 5463.2 5476.9 5479.0 5479.3 5493.8 5530.3 5539.3 5548.0 5595.1 5230.2 5320.4 5331.1 5361.4 5469.1 5361.2 5391.0 5391.3 5397.5 5397.9 5275.1 5295.6 5303.0 5303.7 5367.6 5291.4 5343.4 5363.8 5403.3 5435.6 5185.6 5213.6 5214.2 5214.9 5261.9 13:18:24 INFO - PROCESS | 23609 | 13:18:24 INFO - PROCESS | 23609 | [#1] ext.html Cycles:180 Average:43191.71 Median:19095.36 stddev:72545.57 (379.9%) stddev-sans-first:72678.32 13:18:24 INFO - PROCESS | 23609 | Values: 518.0 556.6 578.0 582.0 593.9 27889.7 28347.7 28372.3 35361.5 36336.0 39326.2 39524.4 39611.6 39637.4 39769.8 8341.7 8542.1 8547.4 8550.4 8554.6 8261.7 8371.3 8385.6 8390.9 8397.1 8296.0 8309.5 8344.2 8358.2 8366.5 8474.0 8523.9 8553.8 8558.4 8560.7 8309.6 8444.5 8457.3 8459.5 8460.1 39169.0 39673.4 39686.4 39735.8 39804.0 3110.3 3144.0 3469.7 3590.0 3854.7 29136.9 29349.1 29555.9 30013.2 30513.7 3850.3 3930.1 3978.0 3993.0 4019.4 202137.0 202282.0 202420.0 202905.0 203892.0 50291.0 50836.2 51040.5 53518.0 55273.7 51569.2 51838.5 51859.5 51878.7 52124.5 12555.2 12704.3 12715.7 12730.8 12733.4 8794.1 8867.0 10039.3 10218.4 10224.4 17859.6 17885.3 17995.2 18027.4 18043.9 6873.5 7197.2 7237.5 7268.5 7310.4 927.0 965.2 976.2 1007.7 1119.7 25264.4 28448.4 30247.0 30564.4 31019.7 1008.0 1012.1 1022.8 1035.0 1041.2 14737.0 15244.0 15414.8 15501.0 16164.6 314877.0 318937.0 319569.0 319720.0 320769.0 50580.7 50743.9 50775.7 50830.7 50844.7 1319.6 1327.0 1344.9 1345.2 1349.4 27476.5 28410.5 28415.3 28533.3 28920.0 43743.6 44121.0 44128.3 44143.8 44166.6 293697.0 296176.0 296658.0 296824.0 296954.0 26680.3 30675.0 31157.1 31302.4 31314.1 37756.8 38277.6 38618.0 38806.6 38940.0 33968.7 34269.7 34324.3 34721.0 35616.3 28640.4 32414.2 32936.8 33251.8 34076.8 33937.0 34039.5 35070.6 35674.6 35690.3 27257.8 30891.1 30948.0 31234.7 31341.5 22897.8 23510.9 23919.3 24181.0 24195.2 13:18:24 INFO - PROCESS | 23609 | 13:18:24 INFO - PROCESS | 23609 | [#2] jquery.html Cycles:180 Average:24101.64 Median:501.78 stddev:71473.81 (14244.0%) stddev-sans-first:71652.09 13:18:24 INFO - PROCESS | 23609 | Values: 363.8 364.3 364.3 365.0 367.5 13494.5 13514.6 15583.9 16739.9 17923.0 15550.0 16049.5 16441.6 16459.3 16740.2 5151.9 5567.6 5569.1 5571.7 5578.7 4002.5 4178.5 5427.5 5526.8 5798.2 5745.5 5911.6 5971.8 5975.6 5983.9 5914.1 5929.6 5938.0 5950.2 5970.2 5148.9 5258.9 5262.1 5339.2 5364.9 19351.7 19580.7 19807.7 19810.7 19829.7 2198.8 2226.4 2291.5 2336.0 2350.8 12290.8 12530.1 12665.7 12669.4 12733.4 1793.6 1817.9 1847.5 1855.9 1945.8 51067.7 55175.4 55854.0 58957.7 60767.0 14650.6 14702.8 14865.5 14919.5 14982.6 22409.8 22418.3 22515.8 22680.2 22711.2 7775.8 7912.8 8252.0 8304.4 8326.5 6852.3 6856.3 6865.9 6891.4 6900.0 7705.1 7708.4 7709.8 7711.2 7771.8 2704.3 3068.0 3068.9 3078.3 3081.3 454.7 462.9 889.5 913.0 955.7 9908.5 10482.9 10567.4 10678.1 10796.6 443.6 444.3 444.5 454.0 458.0 5767.0 5890.9 6136.9 6162.0 6225.8 334641.0 335258.0 484437.0 493842.0 503887.0 61659.8 62584.7 64544.4 64581.4 65123.7 493.9 500.4 503.2 503.5 504.2 8711.1 9874.0 10031.5 10049.8 10282.7 29864.9 30111.3 30594.5 30781.4 31099.4 35295.0 35311.5 35464.0 35995.5 37659.6 6996.3 7024.0 7042.5 7065.1 7159.9 10231.9 10702.1 10805.5 11253.3 11358.7 8521.7 8853.4 9420.6 9518.1 9587.5 8985.0 9367.4 9560.6 9860.1 10046.6 9571.2 9851.8 10017.7 10133.8 10342.4 7423.2 7427.1 7434.9 7450.6 7479.5 8516.3 9580.3 9716.8 9763.5 9984.4 13:18:24 INFO - PROCESS | 23609 | 13:18:24 INFO - PROCESS | 23609 | [#3] mootools.html Cycles:180 Average:5332.33 Median:6110.56 stddev:2750.22 (45.0%) stddev-sans-first:2740.54 13:18:24 INFO - PROCESS | 23609 | Values: 1217.7 1442.2 1450.7 1567.6 1762.3 6774.7 6949.5 7414.7 7490.1 7536.2 7567.5 7590.5 7646.5 7651.7 7654.1 1978.8 2028.8 2252.2 2276.2 2277.6 2258.3 2311.1 2311.8 2312.8 2313.9 2214.1 2230.1 2265.5 2267.6 2270.2 2209.5 2224.7 2232.2 2272.1 2280.0 2250.9 2263.4 2283.4 2286.6 2290.7 7638.2 7657.8 7663.0 7664.9 7670.3 4638.4 4713.0 4744.3 4764.9 4778.7 2970.6 3027.7 3062.5 3076.2 3112.6 946.8 970.4 985.5 1004.4 1019.5 10498.1 10557.9 10587.3 10592.2 10603.4 4146.1 4210.7 4270.3 4312.2 4313.4 8629.7 8664.9 8670.3 8679.5 8684.2 4686.9 4709.6 4728.0 4733.7 4733.7 4365.3 4378.1 4399.3 4407.5 4407.9 3228.9 3274.1 3281.5 3412.1 3501.5 1017.9 1025.7 1073.4 1075.2 1078.2 1014.5 1020.3 1061.2 1092.1 1097.4 7106.5 7128.8 7142.7 7154.6 7159.3 1096.2 1097.4 1107.5 1129.4 1134.4 5533.0 5594.3 5627.9 5639.7 5666.0 8890.6 9243.7 9257.4 9326.9 9370.8 8929.7 8943.5 9042.0 9050.6 9067.5 6788.7 7032.2 7072.0 7077.4 7126.5 6894.0 6940.5 6949.9 6983.9 7022.1 8017.9 8171.2 8194.2 8201.0 8302.0 8321.8 8325.8 8339.4 8356.1 8471.8 6727.9 6977.4 6993.4 6995.7 6995.8 7322.6 7373.3 7380.0 7380.3 7387.1 5728.7 6760.6 6838.7 6872.8 7008.5 6615.2 6649.7 6714.0 6737.1 6904.1 6859.8 6923.9 6947.2 6995.6 6999.6 6062.4 6108.1 6109.4 6111.7 6211.0 6538.1 6557.9 6592.2 6596.1 6602.7 13:18:24 INFO - PROCESS | 23609 | 13:18:24 INFO - PROCESS | 23609 | [#4] prototype.html Cycles:180 Average:5138.65 Median:5812.42 stddev:1539.98 (26.5%) stddev-sans-first:1501.51 13:18:24 INFO - PROCESS | 23609 | Values: 335.5 339.0 344.9 350.2 353.1 5773.8 5823.3 5825.9 5832.4 5857.0 5693.2 5748.1 5762.0 5764.2 5768.1 4502.2 4505.6 4507.7 4508.7 4513.8 4298.8 4453.4 4475.7 4478.8 4480.5 4418.5 4425.4 4425.6 4427.8 4428.9 4220.6 4300.1 4361.5 4404.4 4437.8 3886.0 3911.3 3911.6 3915.1 3918.0 5424.9 5432.0 5459.2 5461.0 5468.8 4816.3 4988.3 4990.6 5005.9 5085.6 6009.1 6013.6 6054.1 6064.5 6075.2 4297.5 4303.3 4305.1 4306.7 4308.9 6243.3 6276.4 6345.9 6348.7 6367.9 4378.6 4386.4 4391.8 4395.3 4397.8 4441.0 4446.7 4449.4 4449.7 4458.6 5101.3 5105.6 5107.7 5110.7 5117.4 5962.4 6117.7 6122.1 6128.9 6133.7 1558.7 1577.7 1578.8 1580.5 1581.7 1061.1 1061.4 1062.0 1075.7 1078.4 5777.9 5786.0 5789.5 5795.4 5801.5 6328.9 6333.9 6341.8 6349.8 6352.6 5826.1 5829.2 5830.9 5836.6 5839.7 3322.2 3400.3 3408.7 3410.3 3413.4 6513.5 6520.3 6520.6 6524.0 6527.2 6333.2 6480.5 6482.3 6495.8 6503.2 6443.0 6546.4 6590.4 6602.5 6617.3 6367.5 6387.3 6390.0 6393.4 6398.9 6118.5 6271.1 6291.5 6319.3 6323.2 6573.6 6574.8 6580.9 6592.6 6593.3 4398.2 4400.4 4400.7 4402.1 4402.9 6173.0 6372.8 6381.7 6382.6 6393.5 6160.5 6170.0 6218.7 6224.0 6228.6 6180.5 6196.8 6198.4 6201.8 6208.8 5909.4 6091.9 6093.7 6097.3 6101.1 6240.1 6242.4 6250.3 6250.7 6254.4 6090.8 6103.9 6104.7 6107.9 6110.3 13:18:24 INFO - PROCESS | 23609 | 13:18:24 INFO - PROCESS | 23609 | [#5] yui.html Cycles:180 Average:14003.09 Median:45966.00 stddev:16378.20 (35.6%) stddev-sans-first:16393.55 13:18:24 INFO - PROCESS | 23609 | Values: 672.4 709.6 834.1 845.2 849.2 12691.5 12838.7 12867.3 12877.4 12885.9 12737.7 12756.0 12786.3 12803.4 12822.4 639.3 645.2 646.2 773.8 789.4 782.4 784.4 785.2 785.4 785.8 822.2 827.0 829.2 830.3 830.5 672.9 814.7 816.8 817.6 821.8 503.4 596.8 604.1 617.6 618.5 12856.0 13006.5 13079.9 13101.1 13134.6 12021.8 12416.9 12421.7 12527.9 12712.7 9991.1 10028.7 10306.9 10308.0 10499.6 3557.5 3564.8 3565.4 3597.3 3693.1 47710.8 47867.0 48504.5 48725.5 50085.5 10231.4 10333.6 10370.7 10465.7 10839.9 18269.0 18301.7 18317.3 18327.5 18335.9 7466.3 7502.1 7543.1 7588.2 7744.8 4120.6 4134.5 4161.4 4188.6 4228.7 3022.4 3056.2 3057.5 3069.1 3069.4 541.0 549.1 550.8 554.2 555.6 628.4 659.8 685.6 688.0 716.2 8021.2 8306.3 8412.7 8487.4 8521.1 478.6 619.9 668.9 675.3 715.6 3729.6 3853.4 3959.8 4074.2 4278.6 58274.7 59361.4 61157.4 62604.0 62733.0 49696.5 50560.0 50599.7 50673.7 50845.7 45612.8 45926.0 46006.0 47438.0 48338.8 8206.6 8528.1 8602.9 8988.4 9169.0 34457.1 34460.0 35797.8 36142.0 36187.8 46984.5 47397.6 47613.3 47771.8 47929.0 10723.9 11212.4 11358.6 11370.7 11480.1 12083.6 12199.5 12639.2 12675.0 12980.9 11247.7 11404.8 11517.9 11725.8 12192.6 11650.5 11845.1 12089.9 12360.1 12372.5 11206.3 11214.0 11237.3 11407.9 11636.8 9818.3 9829.3 9869.6 9994.5 10167.7 9658.9 10147.8 10226.2 10277.1 10290.9 13:18:24 INFO - PROCESS | 23609 | -------- Summary: end -------- 13:18:24 INFO - PROCESS | 23609 | 13:18:24 INFO - TEST-INFO | 23609: exit 0 13:18:24 INFO - TEST-OK | dromaeo_css | took 1112798ms 13:18:24 INFO - TEST-START | kraken 13:18:24 INFO - operating with platform_type : linux_ 13:18:24 INFO - Initialising browser for kraken test... 13:18:24 INFO - TEST-INFO | started process 23807 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpEFJamU/profile http://localhost:45868/getInfo.html) 13:18:28 INFO - PROCESS | 23807 | __metrics Screen width/height:1600/1200 13:18:28 INFO - PROCESS | 23807 | colorDepth:24 13:18:28 INFO - PROCESS | 23807 | Browser inner width/height: 1024/697 13:18:28 INFO - PROCESS | 23807 | __metrics 13:18:28 INFO - PROCESS | 23807 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 13:18:28 INFO - PROCESS | 23807 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:18:29 INFO - TEST-INFO | 23807: exit 0 13:18:29 INFO - Browser initialized. 13:18:29 INFO - Running cycle 1/1 for kraken test... 13:18:29 INFO - TEST-INFO | started process 23889 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpEFJamU/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:18:41 INFO - PROCESS | 23889 | RSS: Main: 149327872 13:18:41 INFO - PROCESS | 23889 | 13:18:44 INFO - PROCESS | 23889 | Cycle 1(1): loaded http://localhost:45868/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45868/tests/kraken/driver.html?testName=audio-beat-detection) 13:18:44 INFO - PROCESS | 23889 | RSS: Main: 187092992 13:18:44 INFO - PROCESS | 23889 | 13:18:47 INFO - PROCESS | 23889 | Cycle 1(1): loaded http://localhost:45868/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45868/tests/kraken/driver.html?testName=audio-dft) 13:18:48 INFO - PROCESS | 23889 | RSS: Main: 176439296 13:18:48 INFO - PROCESS | 23889 | 13:18:50 INFO - PROCESS | 23889 | Cycle 1(1): loaded http://localhost:45868/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45868/tests/kraken/driver.html?testName=audio-fft) 13:18:51 INFO - PROCESS | 23889 | RSS: Main: 161034240 13:18:51 INFO - PROCESS | 23889 | 13:18:53 INFO - PROCESS | 23889 | Cycle 1(1): loaded http://localhost:45868/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45868/tests/kraken/driver.html?testName=audio-oscillator) 13:18:54 INFO - PROCESS | 23889 | RSS: Main: 162926592 13:18:54 INFO - PROCESS | 23889 | 13:18:56 INFO - PROCESS | 23889 | Cycle 1(1): loaded http://localhost:45868/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45868/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:18:56 INFO - PROCESS | 23889 | RSS: Main: 164622336 13:18:56 INFO - PROCESS | 23889 | 13:18:59 INFO - PROCESS | 23889 | Cycle 1(1): loaded http://localhost:45868/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45868/tests/kraken/driver.html?testName=imaging-darkroom) 13:19:00 INFO - PROCESS | 23889 | RSS: Main: 165031936 13:19:00 INFO - PROCESS | 23889 | 13:19:03 INFO - PROCESS | 23889 | Cycle 1(1): loaded http://localhost:45868/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45868/tests/kraken/driver.html?testName=imaging-desaturate) 13:19:04 INFO - PROCESS | 23889 | RSS: Main: 166653952 13:19:04 INFO - PROCESS | 23889 | 13:19:07 INFO - PROCESS | 23889 | Cycle 1(1): loaded http://localhost:45868/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45868/tests/kraken/driver.html?testName=json-parse-financial) 13:19:07 INFO - PROCESS | 23889 | RSS: Main: 167202816 13:19:07 INFO - PROCESS | 23889 | 13:19:09 INFO - PROCESS | 23889 | Cycle 1(1): loaded http://localhost:45868/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45868/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:19:09 INFO - PROCESS | 23889 | RSS: Main: 180244480 13:19:09 INFO - PROCESS | 23889 | 13:19:11 INFO - PROCESS | 23889 | Cycle 1(1): loaded http://localhost:45868/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45868/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:19:12 INFO - PROCESS | 23889 | RSS: Main: 177053696 13:19:12 INFO - PROCESS | 23889 | 13:19:14 INFO - PROCESS | 23889 | Cycle 1(1): loaded http://localhost:45868/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45868/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:19:14 INFO - PROCESS | 23889 | RSS: Main: 181424128 13:19:14 INFO - PROCESS | 23889 | 13:19:17 INFO - PROCESS | 23889 | Cycle 1(1): loaded http://localhost:45868/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45868/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:19:17 INFO - PROCESS | 23889 | RSS: Main: 193044480 13:19:17 INFO - PROCESS | 23889 | 13:19:20 INFO - PROCESS | 23889 | Cycle 1(1): loaded http://localhost:45868/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45868/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:19:20 INFO - PROCESS | 23889 | RSS: Main: 190070784 13:19:20 INFO - PROCESS | 23889 | 13:19:22 INFO - PROCESS | 23889 | Cycle 1(1): loaded http://localhost:45868/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45868/tests/kraken/driver.html?testName=ai-astar) 13:19:22 INFO - PROCESS | 23889 | RSS: Main: 249036800 13:19:22 INFO - PROCESS | 23889 | 13:19:22 INFO - PROCESS | 23889 | __start_tp_report 13:19:22 INFO - PROCESS | 23889 | _x_x_mozilla_page_load 13:19:22 INFO - PROCESS | 23889 | _x_x_mozilla_page_load_details 13:19:22 INFO - PROCESS | 23889 | |i|pagename|runs| 13:19:22 INFO - PROCESS | 23889 | |0;ai-astar;112;111;106;111;111;111;112;112;106;109 13:19:22 INFO - PROCESS | 23889 | |1;audio-beat-detection;159;127;153;173;128;156;150;132;179;136 13:19:22 INFO - PROCESS | 23889 | |2;audio-dft;163;161;160;161;162;160;160;159;163;162 13:19:22 INFO - PROCESS | 23889 | |3;audio-fft;71;73;114;97;73;73;73;99;95;75 13:19:22 INFO - PROCESS | 23889 | |4;audio-oscillator;96;96;155;97;97;96;142;96;97;137 13:19:22 INFO - PROCESS | 23889 | |5;imaging-gaussian-blur;109;116;109;111;108;109;110;109;109;110 13:19:22 INFO - PROCESS | 23889 | |6;imaging-darkroom;147;145;146;147;145;145;145;145;145;146 13:19:22 INFO - PROCESS | 23889 | |7;imaging-desaturate;96;96;97;96;96;96;96;96;96;96 13:19:22 INFO - PROCESS | 23889 | |8;json-parse-financial;56;54;56;55;56;56;55;55;60;54 13:19:22 INFO - PROCESS | 23889 | |9;json-stringify-tinderbox;68;67;67;67;69;69;69;68;67;68 13:19:22 INFO - PROCESS | 23889 | |10;stanford-crypto-aes;83;81;91;84;83;84;83;83;84;92 13:19:22 INFO - PROCESS | 23889 | |11;stanford-crypto-ccm;122;114;119;124;115;116;122;117;114;120 13:19:22 INFO - PROCESS | 23889 | |12;stanford-crypto-pbkdf2;132;142;155;142;144;130;147;140;142;144 13:19:22 INFO - PROCESS | 23889 | |13;stanford-crypto-sha256-iterative;66;66;71;66;66;67;65;65;68;67 13:19:22 INFO - PROCESS | 23889 | __end_tp_report 13:19:22 INFO - PROCESS | 23889 | __start_cc_report 13:19:22 INFO - PROCESS | 23889 | _x_x_mozilla_cycle_collect,952 13:19:22 INFO - PROCESS | 23889 | __end_cc_report 13:19:22 INFO - PROCESS | 23889 | __startTimestamp1453324762648__endTimestamp 13:19:22 INFO - PROCESS | 23889 | 13:19:22 INFO - PROCESS | 23889 | ------- Summary: start ------- 13:19:22 INFO - PROCESS | 23889 | Number of tests: 14 13:19:22 INFO - PROCESS | 23889 | 13:19:22 INFO - PROCESS | 23889 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.00 stddev:2.33 (2.1%) stddev-sans-first:2.37 13:19:22 INFO - PROCESS | 23889 | Values: 112.0 111.0 106.0 111.0 111.0 111.0 112.0 112.0 106.0 109.0 13:19:22 INFO - PROCESS | 23889 | 13:19:22 INFO - PROCESS | 23889 | [#1] audio-beat-detection Cycles:10 Average:149.30 Median:154.50 stddev:18.33 (11.9%) stddev-sans-first:19.10 13:19:22 INFO - PROCESS | 23889 | Values: 159.0 127.0 153.0 173.0 128.0 156.0 150.0 132.0 179.0 136.0 13:19:22 INFO - PROCESS | 23889 | 13:19:22 INFO - PROCESS | 23889 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.50 stddev:1.37 (0.8%) stddev-sans-first:1.27 13:19:22 INFO - PROCESS | 23889 | Values: 163.0 161.0 160.0 161.0 162.0 160.0 160.0 159.0 163.0 162.0 13:19:22 INFO - PROCESS | 23889 | 13:19:22 INFO - PROCESS | 23889 | [#3] audio-fft Cycles:10 Average:84.30 Median:74.00 stddev:15.45 (20.9%) stddev-sans-first:15.62 13:19:22 INFO - PROCESS | 23889 | Values: 71.0 73.0 114.0 97.0 73.0 73.0 73.0 99.0 95.0 75.0 13:19:22 INFO - PROCESS | 23889 | 13:19:22 INFO - PROCESS | 23889 | [#4] audio-oscillator Cycles:10 Average:110.90 Median:96.00 stddev:23.71 (24.7%) stddev-sans-first:24.53 13:19:22 INFO - PROCESS | 23889 | Values: 96.0 96.0 155.0 97.0 97.0 96.0 142.0 96.0 97.0 137.0 13:19:22 INFO - PROCESS | 23889 | 13:19:22 INFO - PROCESS | 23889 | [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:109.50 stddev:2.26 (2.1%) stddev-sans-first:2.37 13:19:22 INFO - PROCESS | 23889 | Values: 109.0 116.0 109.0 111.0 108.0 109.0 110.0 109.0 109.0 110.0 13:19:22 INFO - PROCESS | 23889 | 13:19:22 INFO - PROCESS | 23889 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:145.50 stddev:0.84 (0.6%) stddev-sans-first:0.73 13:19:22 INFO - PROCESS | 23889 | Values: 147.0 145.0 146.0 147.0 145.0 145.0 145.0 145.0 145.0 146.0 13:19:22 INFO - PROCESS | 23889 | 13:19:22 INFO - PROCESS | 23889 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 13:19:22 INFO - PROCESS | 23889 | Values: 96.0 96.0 97.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 13:19:22 INFO - PROCESS | 23889 | 13:19:22 INFO - PROCESS | 23889 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:56.00 stddev:1.70 (3.0%) stddev-sans-first:1.80 13:19:22 INFO - PROCESS | 23889 | Values: 56.0 54.0 56.0 55.0 56.0 56.0 55.0 55.0 60.0 54.0 13:19:22 INFO - PROCESS | 23889 | 13:19:22 INFO - PROCESS | 23889 | [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:68.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 13:19:22 INFO - PROCESS | 23889 | Values: 68.0 67.0 67.0 67.0 69.0 69.0 69.0 68.0 67.0 68.0 13:19:22 INFO - PROCESS | 23889 | 13:19:22 INFO - PROCESS | 23889 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:84.00 stddev:3.65 (4.3%) stddev-sans-first:3.81 13:19:22 INFO - PROCESS | 23889 | Values: 83.0 81.0 91.0 84.0 83.0 84.0 83.0 83.0 84.0 92.0 13:19:22 INFO - PROCESS | 23889 | 13:19:22 INFO - PROCESS | 23889 | [#11] stanford-crypto-ccm Cycles:10 Average:118.30 Median:119.50 stddev:3.62 (3.0%) stddev-sans-first:3.59 13:19:22 INFO - PROCESS | 23889 | Values: 122.0 114.0 119.0 124.0 115.0 116.0 122.0 117.0 114.0 120.0 13:19:22 INFO - PROCESS | 23889 | 13:19:22 INFO - PROCESS | 23889 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.80 Median:143.00 stddev:7.07 (4.9%) stddev-sans-first:6.55 13:19:22 INFO - PROCESS | 23889 | Values: 132.0 142.0 155.0 142.0 144.0 130.0 147.0 140.0 142.0 144.0 13:19:22 INFO - PROCESS | 23889 | 13:19:22 INFO - PROCESS | 23889 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:66.50 stddev:1.77 (2.7%) stddev-sans-first:1.86 13:19:22 INFO - PROCESS | 23889 | Values: 66.0 66.0 71.0 66.0 66.0 67.0 65.0 65.0 68.0 67.0 13:19:22 INFO - PROCESS | 23889 | -------- Summary: end -------- 13:19:22 INFO - PROCESS | 23889 | 13:19:23 INFO - TEST-INFO | 23889: exit 0 13:19:23 INFO - TEST-OK | kraken | took 58831ms 13:19:23 INFO - TEST-START | v8_7 13:19:23 INFO - operating with platform_type : linux_ 13:19:23 INFO - Initialising browser for v8_7 test... 13:19:23 INFO - TEST-INFO | started process 24139 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3gToYP/profile http://localhost:45868/getInfo.html) 13:19:27 INFO - PROCESS | 24139 | __metrics Screen width/height:1600/1200 13:19:27 INFO - PROCESS | 24139 | colorDepth:24 13:19:27 INFO - PROCESS | 24139 | Browser inner width/height: 1024/697 13:19:27 INFO - PROCESS | 24139 | __metrics 13:19:27 INFO - PROCESS | 24139 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 13:19:27 INFO - PROCESS | 24139 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:19:28 INFO - TEST-INFO | 24139: exit 0 13:19:28 INFO - Browser initialized. 13:19:28 INFO - Running cycle 1/1 for v8_7 test... 13:19:28 INFO - TEST-INFO | started process 24223 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3gToYP/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:19:40 INFO - PROCESS | 24223 | RSS: Main: 149004288 13:19:40 INFO - PROCESS | 24223 | 13:20:03 INFO - PROCESS | 24223 | Cycle 1(1): loaded http://localhost:45868/tests/v8_7/run.html (next: http://localhost:45868/tests/v8_7/run.html) 13:20:03 INFO - PROCESS | 24223 | RSS: Main: 571875328 13:20:03 INFO - PROCESS | 24223 | 13:20:03 INFO - PROCESS | 24223 | __start_tp_report 13:20:03 INFO - PROCESS | 24223 | _x_x_mozilla_page_load 13:20:03 INFO - PROCESS | 24223 | _x_x_mozilla_page_load_details 13:20:03 INFO - PROCESS | 24223 | |i|pagename|runs| 13:20:03 INFO - PROCESS | 24223 | |0;Richards;166.72224074691565 13:20:03 INFO - PROCESS | 24223 | |1;DeltaBlue;189.9335232668566 13:20:03 INFO - PROCESS | 24223 | |2;Encrypt;283.36639274582035 13:20:03 INFO - PROCESS | 24223 | |3;Decrypt;5181.347150259067 13:20:03 INFO - PROCESS | 24223 | |4;RayTrace;1998.0039920159682 13:20:03 INFO - PROCESS | 24223 | |5;Earley;770.5927636643572 13:20:03 INFO - PROCESS | 24223 | |6;Boyer;12268.292682926829 13:20:03 INFO - PROCESS | 24223 | |7;RegExp;41693.87755102041 13:20:03 INFO - PROCESS | 24223 | |8;Splay;562.429696287964 13:20:03 INFO - PROCESS | 24223 | |9;NavierStokes;4840.579710144928 13:20:03 INFO - PROCESS | 24223 | __end_tp_report 13:20:03 INFO - PROCESS | 24223 | __startTimestamp1453324803299__endTimestamp 13:20:03 INFO - PROCESS | 24223 | 13:20:03 INFO - PROCESS | 24223 | ------- Summary: start ------- 13:20:03 INFO - PROCESS | 24223 | Number of tests: 10 13:20:03 INFO - PROCESS | 24223 | 13:20:03 INFO - PROCESS | 24223 | [#0] Richards Cycles:1 Average:166.72 Median:166.72 stddev:0.00 (0.0%) 13:20:03 INFO - PROCESS | 24223 | Values: 166.7 13:20:03 INFO - PROCESS | 24223 | 13:20:03 INFO - PROCESS | 24223 | [#1] DeltaBlue Cycles:1 Average:189.93 Median:189.93 stddev:0.00 (0.0%) 13:20:03 INFO - PROCESS | 24223 | Values: 189.9 13:20:03 INFO - PROCESS | 24223 | 13:20:03 INFO - PROCESS | 24223 | [#2] Encrypt Cycles:1 Average:283.37 Median:283.37 stddev:0.00 (0.0%) 13:20:03 INFO - PROCESS | 24223 | Values: 283.4 13:20:03 INFO - PROCESS | 24223 | 13:20:03 INFO - PROCESS | 24223 | [#3] Decrypt Cycles:1 Average:5181.35 Median:5181.35 stddev:0.00 (0.0%) 13:20:03 INFO - PROCESS | 24223 | Values: 5181.3 13:20:03 INFO - PROCESS | 24223 | 13:20:03 INFO - PROCESS | 24223 | [#4] RayTrace Cycles:1 Average:1998.00 Median:1998.00 stddev:0.00 (0.0%) 13:20:03 INFO - PROCESS | 24223 | Values: 1998.0 13:20:03 INFO - PROCESS | 24223 | 13:20:03 INFO - PROCESS | 24223 | [#5] Earley Cycles:1 Average:770.59 Median:770.59 stddev:0.00 (0.0%) 13:20:03 INFO - PROCESS | 24223 | Values: 770.6 13:20:03 INFO - PROCESS | 24223 | 13:20:03 INFO - PROCESS | 24223 | [#6] Boyer Cycles:1 Average:12268.29 Median:12268.29 stddev:0.00 (0.0%) 13:20:03 INFO - PROCESS | 24223 | Values: 12268.3 13:20:03 INFO - PROCESS | 24223 | 13:20:03 INFO - PROCESS | 24223 | [#7] RegExp Cycles:1 Average:41693.88 Median:41693.88 stddev:0.00 (0.0%) 13:20:03 INFO - PROCESS | 24223 | Values: 41693.9 13:20:03 INFO - PROCESS | 24223 | 13:20:03 INFO - PROCESS | 24223 | [#8] Splay Cycles:1 Average:562.43 Median:562.43 stddev:0.00 (0.0%) 13:20:03 INFO - PROCESS | 24223 | Values: 562.4 13:20:03 INFO - PROCESS | 24223 | 13:20:03 INFO - PROCESS | 24223 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 13:20:03 INFO - PROCESS | 24223 | Values: 4840.6 13:20:03 INFO - PROCESS | 24223 | -------- Summary: end -------- 13:20:03 INFO - PROCESS | 24223 | 13:20:04 INFO - TEST-INFO | 24223: exit 0 13:20:04 INFO - TEST-OK | v8_7 | took 40600ms 13:20:04 INFO - SUITE-END | took 1212s 13:20:04 INFO - Completed test suite (00:20:12) 13:20:04 INFO - Working with test: dromaeo_css 13:20:04 INFO - Generating results file: dromaeo_css 13:20:04 INFO - Working with test: kraken 13:20:04 INFO - Generating results file: kraken 13:20:04 INFO - javascript benchmark 13:20:04 INFO - Working with test: v8_7 13:20:04 INFO - Generating results file: v8_7 13:20:04 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:20:06 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,35]] 13:20:06 INFO - process_Request line: dromaeo_css 6679.24 graph.html#tests=[[72,63,35]] 13:20:06 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:20:06 INFO - process_Request line: kraken 1502.60 graph.html#tests=[[232,63,35]] 13:20:06 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:20:06 INFO - process_Request line: v8_7 19061.23 graph.html#tests=[[230,63,35]] 13:20:06 INFO - RETURN: dromaeo_css: 6679.24 13:20:06 INFO - RETURN: kraken: 1502.60 13:20:06 INFO - RETURN: v8_7: 19061.23 13:20:06 INFO - javascript benchmark 13:20:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3063.172943305306, 3066.3407367416003, 3115.2834847984964, 3117.423276693813, 3147.669494703056, 4990.251462280659, 5082.4917508249155, 5144.562712169465, 5146.176611742122, 5164.173732202848, 5024.0454313680375, 5115.667481613693, 5150.1244788385975, 5228.241904923793, 5235.319408476893, 4605.148047611186, 4623.884402889929, 4643.489216186217, 4659.790309436066, 4696.483386827446, 4420.446567816783, 4753.952460475385, 4800.3279540864305, 4843.467218605951, 4855.975720121412, 4592.425946756655, 4659.161350956826, 4665.230237010889, 4787.281907713854, 4834.661573689843, 4695.859124226278, 4722.858314250578, 4725.787339569728, 4726.7400292983875, 4730.62155027597, 4680.695754775963, 4692.085043416535, 4695.577398034194, 4697.765111744399, 4698.201305778026, 4906.754662266872, 4976.4277108132665, 4988.376452943382, 4995.8501244962345, 5007.474215207387, 5571.025070612667, 5571.13647384656, 5578.581606379537, 5592.496675299202, 5597.132444471114, 5411.702356370398, 5418.566514678816, 5613.326400831886, 5684.033714268584, 5685.061964775807, 5098.133317336062, 5154.716490593016, 5196.818111366084, 5197.272381866504, 5239.502247286502, 5569.192467092249, 5603.075492543766, 5606.074997625346, 5619.887602247933, 5663.773449062074, 5268.841934741964, 5351.625386223005, 5401.108817045222, 5401.729913504388, 5402.51377376038, 5368.677879327252, 5403.243545903577, 5408.3509978802795, 5419.918701219406, 5459.344878614592, 5414.3232095988005, 5447.809326673548, 5456.863578410492, 5464.098423760114, 5509.0, 5308.309919710413, 5410.431904650034, 5414.485623865727, 5446.591505637093, 5480.534154596904, 4291.077418355068, 4312.741235525878, 4317.589828966243, 4342.478902531717, 4371.322445020964, 3807.8286477108595, 3855.306044911943, 3873.1479074603544, 3884.378499440076, 3890.7860067696547, 4957.504249575086, 5037.19404895215, 5104.69371837691, 5116.283720279164, 5120.539151476385, 5516.200150978086, 5537.197106419547, 5558.360788509292, 5569.832905012856, 5574.749136288877, 5140.948590514122, 5151.536361727388, 5154.407243167008, 5172.0, 5217.556507696889, 4566.70316429431, 4659.65052621048, 4746.098241334135, 4760.357351757469, 4824.131656301899, 5552.3892371839065, 5558.471945165203, 5558.999999999919, 5559.444055594408, 5563.13771365439, 5343.732813359395, 5392.838214853561, 5404.8108316208745, 5424.0, 5446.455354464521, 5575.163725441216, 5671.744771485375, 5672.376038635829, 5694.1458781183155, 5738.885222295614, 5432.429594892479, 5463.207834863843, 5476.91784623239, 5479.0, 5479.287692599936, 5493.807716729895, 5530.281063461724, 5539.307586551681, 5548.029094908295, 5595.132754423071, 5230.163173892159, 5320.388155362183, 5331.09371406854, 5361.4370491099435, 5469.070258056219, 5361.24942508057, 5391.002664507078, 5391.272178255886, 5397.487238712316, 5397.865053373697, 5275.076861549291, 5295.602829787705, 5303.003941959242, 5303.708296043755, 5367.597430192673, 5291.417944026077, 5343.3587969443915, 5363.758630861543, 5403.324584426947, 5435.592330575302, 5185.559227465707, 5213.582913366846, 5214.165733482625, 5214.921776173436, 5261.921071183859], "unit": "score", "name": "dojo.html", "value": 5068.186748026444}, {"lowerIsBetter": false, "replicates": [517.984460466186, 556.5825630776917, 577.9797707080252, 581.9844371571609, 593.8574742061903, 27889.721102788964, 28347.716522834766, 28372.290692732666, 35361.46957795629, 36336.0, 39326.21347573047, 39524.407133893015, 39611.60388396115, 39637.40543891844, 39769.80115099427, 8341.708040218578, 8542.14578542147, 8547.444416112963, 8550.40147189697, 8554.61504232308, 8261.669533218665, 8371.288440482565, 8385.62264698087, 8390.874136887951, 8397.076321604618, 8296.045954715195, 8309.459885107479, 8344.165583441669, 8358.164183581654, 8366.53984030878, 8473.95763021184, 8523.872141917876, 8553.786155346135, 8558.400911936167, 8560.657573697044, 8309.626066826946, 8444.451110677786, 8457.323414126917, 8459.492430454193, 8460.111688272766, 39169.0, 39673.404898926536, 39686.40470392947, 39735.8013209935, 39804.0, 3110.322513307596, 3143.984280078585, 3469.7224222062173, 3590.0, 3854.7494412863075, 29136.854315728287, 29349.11952641424, 29555.852220738758, 30013.24966875824, 30513.694863051307, 3850.268448994682, 3930.1353702185475, 3978.0, 3993.0416699991792, 4019.376996565537, 202137.0, 202282.0, 202420.0, 202905.0, 203892.0, 50291.0, 50836.23745643818, 51040.48959510357, 53518.0, 55273.72363138159, 51569.2264616031, 51838.48161518412, 51859.48140518622, 51878.74060629673, 52124.47875521272, 12555.183913045623, 12704.301263430416, 12715.682107947376, 12730.80903786444, 12733.426995785212, 8794.120587941283, 8866.955665221632, 10039.297249192487, 10218.386896786216, 10224.437655928847, 17859.553511162067, 17885.28458861657, 17995.190216440293, 18027.369042083465, 18043.909780451013, 6873.503591380726, 7197.244289349543, 7237.529560578546, 7268.491205615662, 7310.4151667866445, 927.0451435021938, 965.2133511188359, 976.2287792643874, 1007.7077647482295, 1119.7256672115384, 25264.36839079001, 28448.43103137967, 30247.0, 30564.38871222563, 31019.68980310213, 1007.9848802267971, 1012.0790081026231, 1022.7954409118206, 1034.9546957572754, 1041.1670663469195, 14737.0, 15244.0, 15414.845851541566, 15500.984871966572, 16164.595885102732, 314877.0, 318937.0, 319569.0, 319720.0, 320769.0, 50580.747096264284, 50743.91073071255, 50775.746121269156, 50830.74584627053, 50844.74577627088, 1319.577735124751, 1327.0, 1344.9125806822526, 1345.1861623717705, 1349.4399824073096, 27476.45047099087, 28410.495673325695, 28415.289617758895, 28533.28666783264, 28920.0, 43743.56256437395, 44121.0, 44128.33807492955, 44143.77928110339, 44166.55833441753, 293697.0, 296176.0, 296658.0, 296824.0, 296954.0, 26680.332991675365, 30675.0, 31157.065288041395, 31302.373952520367, 31314.060578182693, 37756.81121594484, 38277.61722382741, 38618.0, 38806.6119338803, 38940.0, 33968.66031339655, 34269.657303427644, 34324.313513730085, 34721.0, 35616.28767424689, 28640.42719145647, 32414.189645258113, 32936.835315824224, 33251.83374083114, 34076.82961585176, 33937.0, 34039.48940765841, 35070.64929350776, 35674.64325356817, 35690.286194275446, 27257.827399872822, 30891.083171760773, 30947.990224740533, 31234.68765312409, 31341.52987705232, 22897.771022289562, 23510.882445588348, 23919.282421527383, 24181.0, 24195.15316963898], "unit": "score", "name": "ext.html", "value": 17439.27499034122}, {"lowerIsBetter": false, "replicates": [363.79445613228523, 364.2823637434254, 364.32054218881785, 364.9616790237025, 367.49652975423675, 13494.527691530799, 13514.594562163125, 15583.922080389597, 16739.916300418496, 17923.0, 15550.0, 16049.518514444557, 16441.588960276, 16459.25933333, 16740.246688899, 5151.896962060757, 5567.582431317647, 5569.10894256919, 5571.721413929307, 5578.748956296977, 4002.4996875390575, 4178.498580170369, 5427.538659213971, 5526.751296191661, 5798.246227990356, 5745.482906538432, 5911.645301281916, 5971.761129554812, 5975.551833612496, 5983.940160598382, 5914.083317085859, 5929.644221346733, 5937.970310148465, 5950.166976623254, 5970.164177015221, 5148.91872706732, 5258.895631917302, 5262.05283049051, 5339.225812257239, 5364.946350536523, 19351.709724354147, 19580.70628940567, 19807.7028844566, 19810.70283945742, 19829.702554461695, 2198.8240940724863, 2226.4100013496436, 2291.5302363015544, 2336.0422226886894, 2350.753170917046, 12290.754184916252, 12530.122891397607, 12665.683357916034, 12669.429875655618, 12733.36333183337, 1793.560577658469, 1817.9181936812874, 1847.4642353717406, 1855.8793678410996, 1945.7956914523913, 51067.744661276825, 55175.44824551743, 55854.0, 58957.705211474095, 60767.0, 14650.63373415673, 14702.779458308134, 14865.466032860082, 14919.477818276308, 14982.550523484095, 22409.767462789376, 22418.32745017652, 22515.761633110007, 22680.16497937758, 22711.205107821148, 7775.844483110306, 7912.762617121495, 8252.0, 8304.377171712025, 8326.45878017927, 6852.314768523208, 6856.280090590416, 6865.9313406866295, 6891.414229790424, 6900.0, 7705.113911900091, 7708.38332933364, 7709.768706938801, 7711.190325015793, 7771.805704857424, 2704.337437327867, 3068.0, 3068.8772449102235, 3078.26121730783, 3081.2604974805886, 454.7362529732747, 462.8588280574457, 889.5374405309203, 913.0096389870014, 955.7132860141929, 9908.455034973145, 10482.947585262025, 10567.418791966516, 10678.145748340114, 10796.622118225981, 443.6096235312904, 444.34237328753625, 444.517698297351, 453.9773011349419, 458.0381199481063, 5766.971165144231, 5890.911636325459, 6136.8772624548155, 6162.0, 6225.750969961241, 334641.0, 335258.0, 484437.0, 493842.0, 503887.0, 61659.76680466365, 62584.687076565235, 64544.354556453836, 64581.35418645848, 65123.674381628734, 493.87899964508927, 500.36703569984, 503.1999121396996, 503.52920019781624, 504.20587574569464, 8711.085336039878, 9873.950630246803, 10031.498425078862, 10049.799004019733, 10282.691519254435, 29864.850675746482, 30111.289983901555, 30594.541081883344, 30781.38437231198, 31099.378012440076, 35295.0, 35311.470327945615, 35464.0, 35995.46006809847, 37659.62340376561, 6996.335348141918, 7024.016637670628, 7042.542234754725, 7065.0815393998455, 7159.856802863809, 10231.94884025575, 10702.143828493858, 10805.513751881026, 11253.324800511995, 11358.716032099264, 8521.744347669579, 8853.380263381501, 9420.576074076545, 9518.143367096995, 9587.520623968912, 8985.0, 9367.391119577205, 9560.569774360032, 9860.06329398706, 10046.648367307109, 9571.1864491519, 9851.763741591185, 10017.749556261151, 10133.847992280269, 10342.37945723259, 7423.1834498206235, 7427.071616047994, 7434.888476672746, 7450.552966822008, 7479.513831600929, 8516.276116529916, 9580.281478888972, 9716.805663886824, 9763.511824408894, 9984.35101718386], "unit": "score", "name": "jquery.html", "value": 7863.7078527139065}, {"lowerIsBetter": false, "replicates": [1217.7442737025224, 1442.1563385419533, 1450.7171101635179, 1567.5983116636896, 1762.3038899634653, 6774.729010839566, 6949.548279361838, 7414.703411863519, 7490.101187857451, 7536.208698086704, 7567.545947243169, 7590.468667193299, 7646.502977306485, 7651.732189373373, 7654.081510218782, 1978.8317992970542, 2028.8072633099905, 2252.155441709355, 2276.169198242646, 2277.5900337939165, 2258.2660635293514, 2311.133325003124, 2311.780380863815, 2312.8034117100065, 2313.9471540449053, 2214.1143542583013, 2230.119102954332, 2265.546890621874, 2267.6258417361114, 2270.2054281001683, 2209.5470428562107, 2224.699665545155, 2232.1964092926614, 2272.091163534583, 2280.0309868305903, 2250.8762018089, 2263.3888850010403, 2283.4177284792436, 2286.6112760830697, 2290.6907567478343, 7638.197989211164, 7657.770266892002, 7663.0, 7664.885026724603, 7670.348020418215, 4638.420197475316, 4712.976435117836, 4744.264638980963, 4764.857054288377, 4778.665493415462, 2970.569267456207, 3027.697230276977, 3062.494688376415, 3076.2001879511263, 3112.6264848218357, 946.8437707778209, 970.3741086998916, 985.5269470654055, 1004.4324956399611, 1019.4749703902496, 10498.107660848837, 10557.894421055767, 10587.258891877571, 10592.15262778976, 10603.363798172135, 4146.108586653884, 4210.705250632487, 4270.295401258758, 4312.202242585132, 4313.41768861206, 8629.741107766777, 8664.8700269496, 8670.306375489945, 8679.479231246145, 8684.175003374668, 4686.882827929329, 4709.552592503706, 4727.976360118178, 4733.668643194943, 4733.692309999839, 4365.257906155897, 4378.10248898975, 4399.340098985178, 4407.493138289074, 4407.867763967086, 3228.870845166167, 3274.099622603803, 3281.45855933773, 3412.112850658797, 3501.5447991760907, 1017.9338343007829, 1025.6564051042835, 1073.4257172412879, 1075.166745772033, 1078.2075174746556, 1014.5181039006413, 1020.3316827477865, 1061.2412125330272, 1092.1317552545745, 1097.3964319624174, 7106.502544821917, 7128.750493732695, 7142.678579463936, 7154.570725756471, 7159.284071592799, 1096.2326371539955, 1097.4074000040048, 1107.4850194659361, 1129.4465711801158, 1134.3647557367901, 5533.0, 5594.300712410949, 5627.8593035174445, 5639.661620302795, 5666.036773748473, 8890.59992300348, 9243.722688319362, 9257.444553326823, 9326.90673093274, 9370.812583748288, 8929.73210803677, 8943.508107054175, 9042.0, 9050.637974481078, 9067.501287429255, 6788.660566971632, 7032.156141263081, 7071.964640176869, 7077.398421134261, 7126.536775109601, 6893.965530172317, 6940.479464040318, 6949.895751563832, 6983.930160698531, 7022.12223472066, 8017.879731804144, 8171.182881711781, 8194.22154895284, 8201.0, 8301.958490207511, 8321.791955200926, 8325.791855203668, 8339.416240863082, 8356.122607126164, 8471.830563388821, 6727.8990815138795, 6977.406920411822, 6993.440524757905, 6995.720171193096, 6995.755148569776, 7322.63386830667, 7373.262673732584, 7380.0, 7380.261973802577, 7387.076615423072, 5728.684922329312, 6760.594364338155, 6838.7264509419065, 6872.793816185523, 7008.544444611084, 6615.17310336208, 6649.700763465559, 6714.0, 6737.056812046416, 6904.067950826574, 6859.794206173823, 6923.93076069253, 6947.23580406165, 6995.615241161785, 6999.615021173884, 6062.393760624079, 6108.053251745987, 6109.389061093855, 6111.7249723763425, 6211.0372892201785, 6538.084668146368, 6557.868842623217, 6592.24189218246, 6596.142501474777, 6602.702878370581], "unit": "score", "name": "mootools.html", "value": 4377.334127254069}, {"lowerIsBetter": false, "replicates": [335.50010484378276, 338.9949150762739, 344.85171376308176, 350.2190116041228, 353.14186526740025, 5773.826785196446, 5823.3012038555435, 5825.854353641161, 5832.445917637818, 5857.033589457739, 5693.202951586781, 5748.051571490699, 5761.971190144054, 5764.221830052941, 5768.134779783035, 4502.23462011458, 4505.639548836085, 4507.684462087655, 4508.72947623142, 4513.819447222108, 4298.763568003758, 4453.4433195850515, 4475.664325175609, 4478.776061196927, 4480.484744254403, 4418.513963464016, 4425.402570652969, 4425.645948324142, 4427.800748966304, 4428.867133985986, 4220.641245494121, 4300.075483770973, 4361.476622805252, 4404.4494438195225, 4437.755923424211, 3886.0479182600443, 3911.2764138634443, 3911.5697273299916, 3915.11909820291, 3918.0400801803457, 5424.864378390533, 5432.0, 5459.181122831567, 5461.0, 5468.7539060742365, 4816.301636262722, 4988.251762235657, 4990.575801056914, 5005.874853128665, 5085.618578606583, 6009.128676341906, 6013.639181649071, 6054.122152287938, 6064.4541991221, 6075.210222671025, 4297.462817147856, 4303.33298338758, 4305.117450922553, 4306.676999225039, 4308.9138217235795, 6243.2508099027955, 6276.372362763733, 6345.904811427832, 6348.682565871688, 6367.872642547123, 4378.562143785596, 4386.385905973167, 4391.824327026947, 4395.296752519582, 4397.780110994501, 4441.045175287329, 4446.73319600825, 4449.421575195204, 4449.665100469846, 4458.621017213573, 5101.2603172539775, 5105.642605017613, 5107.668001579886, 5110.744462776846, 5117.437081920985, 5962.403759624003, 6117.694115294306, 6122.051082082285, 6128.908066379008, 6133.723982420802, 1558.688262347535, 1577.7081239970641, 1578.8263291037977, 1580.5100418870188, 1581.667849751565, 1061.124572227915, 1061.3525749292926, 1062.0388548363744, 1075.6988043347876, 1078.4230436716318, 5777.94222057774, 5785.971070144707, 5789.507891829157, 5795.391483894215, 5801.53587712982, 6328.873422531524, 6333.904991425133, 6341.8097457076365, 6349.777757778548, 6352.618842869442, 5826.067829147316, 5829.154772557956, 5830.941690583039, 5836.562257830679, 5839.678817664984, 3322.202671358905, 3400.3369342978376, 3408.693217610427, 3410.3349846780134, 3413.35146322198, 6513.478921686254, 6520.250171230275, 6520.641364724986, 6524.021396790519, 6527.184101987252, 6333.1766870306565, 6480.4815614750705, 6482.254540727877, 6495.837604059841, 6503.154589903283, 6442.967785161044, 6546.443552298013, 6590.439812615886, 6602.537822352389, 6617.272100068989, 6367.52243581724, 6387.329330420424, 6389.968050159905, 6393.360663933569, 6398.936010639834, 6118.541109416722, 6271.059341098871, 6291.465225455888, 6319.3364696706185, 6323.20959880015, 6573.638449885302, 6574.8356291093105, 6580.934190658224, 6592.604443733391, 6593.274739778524, 4398.230309695854, 4400.405945197357, 4400.669949753846, 4402.097569998079, 4402.911941761083, 6173.0, 6372.776952806629, 6381.680915954091, 6382.5532212744665, 6393.520485963479, 6160.537959652955, 6170.0, 6218.689065546614, 6224.0, 6228.5951413158, 6180.47465965398, 6196.845078872884, 6198.442140207223, 6201.844953876189, 6208.844778880383, 5909.409059094228, 6091.878162436815, 6093.725782339717, 6097.2988106366565, 6101.084837274267, 6240.126382306572, 6242.438180563589, 6250.281217660027, 6250.718717657807, 6254.437100660963, 6090.786822461193, 6103.908441373294, 6104.694765261808, 6107.9389206109145, 6110.297315808739], "unit": "score", "name": "prototype.html", "value": 4646.286475576036}, {"lowerIsBetter": false, "replicates": [672.3780503034693, 709.6380845768656, 834.1116710703103, 845.1801752300266, 849.2314455417845, 12691.492340306388, 12838.679033024178, 12867.292298923556, 12877.356132193376, 12885.935570322135, 12737.745245095093, 12756.0, 12786.296753678544, 12803.359832008386, 12822.358882055907, 639.3223183425583, 645.2225068792094, 646.2148489585153, 773.8452309538087, 789.3685051958439, 782.3858271257064, 784.3725019984018, 785.2187073861487, 785.3795501553766, 785.7564155111905, 822.2065706593137, 826.9917300826975, 829.1749709039514, 830.3315830756238, 830.4602008694336, 672.9158855143107, 814.7067055859916, 816.7835523586255, 817.6034623207739, 821.8315245374683, 503.4135232454187, 596.8030549918517, 604.1059232336123, 617.6170774120075, 618.4650277509967, 12856.0, 13006.544770932973, 13079.86920130796, 13101.08292419531, 13134.60596182116, 12021.819672704916, 12416.875831241663, 12421.689457763538, 12527.937360313232, 12712.682182945407, 9991.10080092788, 10028.699139025768, 10306.948465257701, 10308.0, 10499.580016799318, 3557.48416479609, 3564.7682900611635, 3565.447355659877, 3597.334493118781, 3693.076730817296, 47710.76144619255, 47867.0, 48504.514954850354, 48725.51274487281, 50085.49914500845, 10231.386116833013, 10333.638322658671, 10370.740731481774, 10465.68602941913, 10839.86181450952, 18269.0, 18301.7254741179, 18317.267309307746, 18327.450176494727, 18335.90832045858, 7466.328030477283, 7502.137254215835, 7543.094828620491, 7588.241175882478, 7744.806379840436, 4120.606522964007, 4134.524529679125, 4161.417401563784, 4188.560201178893, 4228.703990720682, 3022.410629927143, 3056.2053865995003, 3057.5260834570677, 3069.1252992896916, 3069.355435358555, 540.9594280428984, 549.1022178737712, 550.7686771555956, 554.2268535393104, 555.6194007105146, 628.446966669328, 659.8086554899025, 685.6434653980002, 687.9621620810904, 716.1728203924475, 8021.2379823916635, 8306.252437280673, 8412.705555305658, 8487.405881588229, 8521.147885211429, 478.57645983305025, 619.8667286533417, 668.9397954184146, 675.3246753246754, 715.6171448275148, 3729.5572397287488, 3853.3641949078087, 3959.7822119783687, 4074.246264441088, 4278.593533614302, 58274.70862645745, 59361.40638593559, 61157.38842611517, 62604.0, 62733.0, 49696.50303496991, 50560.0, 50599.74700126476, 50673.74663126661, 50845.74577127165, 45612.77193614077, 45926.0, 46006.0, 47438.0, 48338.75830620895, 8206.58967051633, 8528.147185281423, 8602.870956935776, 8988.370814042953, 9169.0, 34457.138571535914, 34460.0, 35797.82101089478, 36142.0, 36187.81906090453, 46984.53015469802, 47397.630118493245, 47613.28580071371, 47771.761141194074, 47929.0, 10723.892761072602, 11212.383318917538, 11358.60244891425, 11370.68389618393, 11480.081593472669, 12083.57707480234, 12199.512019519474, 12639.241645501299, 12675.0, 12980.870191297967, 11247.66257012291, 11404.771904562029, 11517.884821152016, 11725.824112638487, 12192.57325993586, 11650.53397864076, 11845.111616628616, 12089.939550302544, 12360.134790564574, 12372.505099796268, 11206.271592346471, 11214.0, 11237.269577477438, 11407.942960285145, 11636.825447618123, 9818.312718109664, 9829.31194816356, 9869.555869985725, 9994.500274986367, 10167.7458063549, 9658.909468305766, 10147.847782283125, 10226.233032522441, 10277.075063244343, 10290.897091028994], "unit": "score", "name": "yui.html", "value": 6280.571230889533}], "name": "dromaeo_css", "value": 6679.236039815558}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 111.0, 106.0, 111.0, 111.0, 111.0, 112.0, 112.0, 106.0, 109.0], "unit": "score", "name": "ai-astar", "value": 110.1}, {"lowerIsBetter": true, "replicates": [159.0, 127.0, 153.0, 173.0, 128.0, 156.0, 150.0, 132.0, 179.0, 136.0], "unit": "score", "name": "audio-beat-detection", "value": 149.3}, {"lowerIsBetter": true, "replicates": [163.0, 161.0, 160.0, 161.0, 162.0, 160.0, 160.0, 159.0, 163.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.1}, {"lowerIsBetter": true, "replicates": [71.0, 73.0, 114.0, 97.0, 73.0, 73.0, 73.0, 99.0, 95.0, 75.0], "unit": "score", "name": "audio-fft", "value": 84.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 155.0, 97.0, 97.0, 96.0, 142.0, 96.0, 97.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 110.9}, {"lowerIsBetter": true, "replicates": [109.0, 116.0, 109.0, 111.0, 108.0, 109.0, 110.0, 109.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [147.0, 145.0, 146.0, 147.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [56.0, 54.0, 56.0, 55.0, 56.0, 56.0, 55.0, 55.0, 60.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 55.7}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 67.0, 67.0, 69.0, 69.0, 69.0, 68.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.9}, {"lowerIsBetter": true, "replicates": [83.0, 81.0, 91.0, 84.0, 83.0, 84.0, 83.0, 83.0, 84.0, 92.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.8}, {"lowerIsBetter": true, "replicates": [122.0, 114.0, 119.0, 124.0, 115.0, 116.0, 122.0, 117.0, 114.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.3}, {"lowerIsBetter": true, "replicates": [132.0, 142.0, 155.0, 142.0, 144.0, 130.0, 147.0, 140.0, 142.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.8}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 71.0, 66.0, 66.0, 67.0, 65.0, 65.0, 68.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.7}], "name": "kraken", "value": 1502.6000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.72224074691565], "unit": "score", "name": "Richards", "value": 211.74139599999998}, {"lowerIsBetter": false, "replicates": [189.9335232668566], "unit": "score", "name": "DeltaBlue", "value": 348.11126999999993}, {"lowerIsBetter": false, "replicates": [283.36639274582035], "unit": "score", "name": "Encrypt", "value": 939.3527489999996}, {"lowerIsBetter": false, "replicates": [5181.347150259067], "unit": "score", "name": "Decrypt", "value": 51.372933}, {"lowerIsBetter": false, "replicates": [1998.0039920159682], "unit": "score", "name": "RayTrace", "value": 370.36412487512496}, {"lowerIsBetter": false, "replicates": [770.5927636643572], "unit": "score", "name": "Earley", "value": 864.8705664335663}, {"lowerIsBetter": false, "replicates": [12268.292682926829], "unit": "score", "name": "Boyer", "value": 54.32402186878729}, {"lowerIsBetter": false, "replicates": [41693.87755102041], "unit": "score", "name": "RegExp", "value": 21.849371023005364}, {"lowerIsBetter": false, "replicates": [562.429696287964], "unit": "score", "name": "Splay", "value": 144.89099799999994}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 19061.229838528336}]} 13:20:06 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,35]]", "result": "19061.23"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,35]]", "result": "1502.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,35]]", "result": "6679.24"}}} 13:20:06 INFO - Return code: 0 13:20:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 13:20:06 INFO - # TBPL SUCCESS # 13:20:06 INFO - Running post-action listener: _resource_record_post_action 13:20:06 INFO - Running post-run listener: _resource_record_post_run 13:20:07 INFO - Total resource usage - Wall time: 1231s; CPU: 13.0%; Read bytes: 57344; Write bytes: 307220480; Read time: 100; Write time: 205860 13:20:07 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 5218304; Read time: 0; Write time: 668 13:20:07 INFO - run-tests - Wall time: 1216s; CPU: 13.0%; Read bytes: 57344; Write bytes: 302002176; Read time: 100; Write time: 205192 13:20:07 INFO - Running post-run listener: _upload_blobber_files 13:20:07 INFO - Blob upload gear active. 13:20:07 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 13:20:07 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:20:07 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:20:07 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:20:07 INFO - (blobuploader) - INFO - Open directory for files ... 13:20:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:20:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:20:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:20:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:20:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:20:08 INFO - (blobuploader) - INFO - Done attempting. 13:20:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 13:20:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:20:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:20:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:20:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:20:09 INFO - (blobuploader) - INFO - Done attempting. 13:20:09 INFO - (blobuploader) - INFO - Iteration through files over. 13:20:09 INFO - Return code: 0 13:20:09 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 13:20:09 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 13:20:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/97ce308814bc1414dd4ea6453382cc208fd289079530399463c3b81521ea97c8c930e9d8421bfbb93dad0da8827048f71f7ab12b9db113d79f6233b6bec8ab9f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b7a77914d49a7fca162f14c7e98c27d74d44298840eb7fc42e1cfbe234dcbf288d7e9f06e92aad148688145cca20c93cbf2975bb8e62e1244dc405a3262d9f5a"} 13:20:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 13:20:09 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 13:20:09 INFO - Contents: 13:20:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/97ce308814bc1414dd4ea6453382cc208fd289079530399463c3b81521ea97c8c930e9d8421bfbb93dad0da8827048f71f7ab12b9db113d79f6233b6bec8ab9f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b7a77914d49a7fca162f14c7e98c27d74d44298840eb7fc42e1cfbe234dcbf288d7e9f06e92aad148688145cca20c93cbf2975bb8e62e1244dc405a3262d9f5a"} 13:20:09 INFO - Running post-run listener: copy_logs_to_upload_dir 13:20:09 INFO - Copying logs to upload dir... 13:20:09 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 13:20:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.818329 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-01-20 13:20:09.653085) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-20 13:20:09.658109) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1453323539.114316-265268296 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/97ce308814bc1414dd4ea6453382cc208fd289079530399463c3b81521ea97c8c930e9d8421bfbb93dad0da8827048f71f7ab12b9db113d79f6233b6bec8ab9f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b7a77914d49a7fca162f14c7e98c27d74d44298840eb7fc42e1cfbe234dcbf288d7e9f06e92aad148688145cca20c93cbf2975bb8e62e1244dc405a3262d9f5a"} build_url:https://queue.taskcluster.net/v1/task/IWIs2hUYT7C2NB0uDV2DcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011395 build_url: 'https://queue.taskcluster.net/v1/task/IWIs2hUYT7C2NB0uDV2DcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/97ce308814bc1414dd4ea6453382cc208fd289079530399463c3b81521ea97c8c930e9d8421bfbb93dad0da8827048f71f7ab12b9db113d79f6233b6bec8ab9f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b7a77914d49a7fca162f14c7e98c27d74d44298840eb7fc42e1cfbe234dcbf288d7e9f06e92aad148688145cca20c93cbf2975bb8e62e1244dc405a3262d9f5a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-20 13:20:09.683080) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 13:20:09.683411) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1453323539.114316-265268296 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004470 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 13:20:09.767466) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-20 13:20:09.767787) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-20 13:20:09.768083) ========= ========= Total master_lag: 0.25 =========