builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-051 starttime: 1453749719.62 results: success (0) buildid: 20160125032407 builduid: 84a569e400f549d78ae6c3dedf0c2ad7 revision: 3bfa5bc61b626761d487b45c170b115259f69d6b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 11:21:59.624758) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 11:21:59.625274) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 11:21:59.625569) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1453749720.413366-2082337915 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006342 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 11:21:59.654810) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 11:21:59.655116) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 11:21:59.668731) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:21:59.669002) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1453749720.413366-2082337915 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004551 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:21:59.718475) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 11:21:59.718801) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 11:21:59.719175) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:21:59.719472) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1453749720.413366-2082337915 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-25 11:22:01-- 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% 60.4M=0s 2016-01-25 11:22:01 (60.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.114085 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:21:59.845976) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:21:59.846283) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1453749720.413366-2082337915 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020643 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:21:59.896367) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:21:59.896745) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3bfa5bc61b626761d487b45c170b115259f69d6b --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3bfa5bc61b626761d487b45c170b115259f69d6b --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=5ac5dba3e01a12f1ff77ab15000001b1-1453749720.413366-2082337915 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-25 11:22:01,394 truncating revision to first 12 chars 2016-01-25 11:22:01,394 Setting DEBUG logging. 2016-01-25 11:22:01,394 attempt 1/10 2016-01-25 11:22:01,394 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/3bfa5bc61b62?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-25 11:22:01,916 unpacking tar archive at: mozilla-aurora-3bfa5bc61b62/testing/mozharness/ program finished with exit code 0 elapsedTime=0.883048 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:22:00.792782) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 11:22:00.793155) ========= echo 3bfa5bc61b626761d487b45c170b115259f69d6b in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'3bfa5bc61b626761d487b45c170b115259f69d6b'] 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=5ac5dba3e01a12f1ff77ab15000001b1-1453749720.413366-2082337915 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 3bfa5bc61b626761d487b45c170b115259f69d6b program finished with exit code 0 elapsedTime=0.004637 script_repo_revision: '3bfa5bc61b626761d487b45c170b115259f69d6b' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 11:22:00.844342) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 11:22:00.844645) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 11:22:00.855647) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-01-25 11:22:00.855974) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=5ac5dba3e01a12f1ff77ab15000001b1-1453749720.413366-2082337915 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:22:02 INFO - MultiFileLogger online at 20160125 11:22:02 in /builds/slave/test-pgo 11:22:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 11:22:02 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 11:22:02 INFO - {'append_to_log': False, 11:22:02 INFO - 'base_work_dir': '/builds/slave/test-pgo', 11:22:02 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:22:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 11:22:02 INFO - 'branch': 'Mozilla-Aurora', 11:22:02 INFO - 'buildbot_json_path': 'buildprops.json', 11:22:02 INFO - 'config_files': ('talos/linux_config.py',), 11:22:02 INFO - 'default_actions': ('clobber', 11:22:02 INFO - 'read-buildbot-config', 11:22:02 INFO - 'download-and-extract', 11:22:02 INFO - 'populate-webroot', 11:22:02 INFO - 'create-virtualenv', 11:22:02 INFO - 'install', 11:22:02 INFO - 'run-tests'), 11:22:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:22:02 INFO - 'download_minidump_stackwalk': True, 11:22:02 INFO - 'download_symbols': 'ondemand', 11:22:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:22:02 INFO - 'tooltool.py': '/tools/tooltool.py', 11:22:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:22:02 INFO - '/tools/misc-python/virtualenv.py')}, 11:22:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:22:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:22:02 INFO - 'installer_path': 'installer.exe', 11:22:02 INFO - 'log_level': 'info', 11:22:02 INFO - 'log_name': 'talos', 11:22:02 INFO - 'log_to_console': True, 11:22:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:22:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:22:02 INFO - 'opt_config_files': (), 11:22:02 INFO - 'pip_index': False, 11:22:02 INFO - 'sps_profile': False, 11:22:02 INFO - 'sps_profile_interval': 0, 11:22:02 INFO - 'suite': 'dromaeojs-e10s', 11:22:02 INFO - 'system_bits': '32', 11:22:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:22:02 INFO - 'title': 'talos-linux64-ix-051', 11:22:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:22:02 INFO - 'use_talos_json': True, 11:22:02 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 11:22:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:22:02 INFO - 'work_dir': 'build'} 11:22:02 INFO - ##### 11:22:02 INFO - ##### Running clobber step. 11:22:02 INFO - ##### 11:22:02 INFO - Running pre-action listener: _resource_record_pre_action 11:22:02 INFO - Running main action method: clobber 11:22:02 INFO - rmtree: /builds/slave/test-pgo/build 11:22:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 11:22:02 INFO - Running post-action listener: _resource_record_post_action 11:22:02 INFO - ##### 11:22:02 INFO - ##### Running read-buildbot-config step. 11:22:02 INFO - ##### 11:22:02 INFO - Running pre-action listener: _resource_record_pre_action 11:22:02 INFO - Running main action method: read_buildbot_config 11:22:02 INFO - Using buildbot properties: 11:22:02 INFO - { 11:22:02 INFO - "properties": { 11:22:02 INFO - "buildnumber": 112, 11:22:02 INFO - "product": "firefox", 11:22:02 INFO - "script_repo_revision": "production", 11:22:02 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 11:22:02 INFO - "repository": "", 11:22:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 11:22:02 INFO - "buildid": "20160125032407", 11:22:02 INFO - "slavename": "talos-linux64-ix-051", 11:22:02 INFO - "pgo_build": "True", 11:22:02 INFO - "basedir": "/builds/slave/test-pgo", 11:22:02 INFO - "project": "", 11:22:02 INFO - "platform": "ubuntu64_hw", 11:22:02 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:22:02 INFO - "slavebuilddir": "test", 11:22:02 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 11:22:02 INFO - "branch": "mozilla-aurora", 11:22:02 INFO - "repo_path": "releases/mozilla-aurora", 11:22:02 INFO - "stage_platform": "linux64-pgo", 11:22:02 INFO - "builduid": "84a569e400f549d78ae6c3dedf0c2ad7", 11:22:02 INFO - "revision": "3bfa5bc61b626761d487b45c170b115259f69d6b" 11:22:02 INFO - }, 11:22:02 INFO - "sourcestamp": { 11:22:02 INFO - "repository": "", 11:22:02 INFO - "hasPatch": false, 11:22:02 INFO - "project": "", 11:22:02 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 11:22:02 INFO - "changes": [ 11:22:02 INFO - { 11:22:02 INFO - "category": null, 11:22:02 INFO - "files": [ 11:22:02 INFO - { 11:22:02 INFO - "url": null, 11:22:02 INFO - "name": "https://queue.taskcluster.net/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 11:22:02 INFO - } 11:22:02 INFO - ], 11:22:02 INFO - "repository": "", 11:22:02 INFO - "rev": "3bfa5bc61b626761d487b45c170b115259f69d6b", 11:22:02 INFO - "who": "cbook@mozilla.com", 11:22:02 INFO - "when": 1453730728, 11:22:02 INFO - "number": 7510949, 11:22:02 INFO - "comments": "Bug 1234675 - Ability to disable e10s for users with addons. r=Mossop, a=sylvestre", 11:22:02 INFO - "project": "", 11:22:02 INFO - "at": "Mon 25 Jan 2016 06:05:28", 11:22:02 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 11:22:02 INFO - "revlink": "", 11:22:02 INFO - "properties": [ 11:22:02 INFO - [ 11:22:02 INFO - "buildid", 11:22:02 INFO - "20160125032407", 11:22:02 INFO - "Change" 11:22:02 INFO - ], 11:22:02 INFO - [ 11:22:02 INFO - "builduid", 11:22:02 INFO - "84a569e400f549d78ae6c3dedf0c2ad7", 11:22:02 INFO - "Change" 11:22:02 INFO - ], 11:22:02 INFO - [ 11:22:02 INFO - "pgo_build", 11:22:02 INFO - "True", 11:22:02 INFO - "Change" 11:22:02 INFO - ] 11:22:02 INFO - ], 11:22:02 INFO - "revision": "3bfa5bc61b626761d487b45c170b115259f69d6b" 11:22:02 INFO - } 11:22:02 INFO - ], 11:22:02 INFO - "revision": "3bfa5bc61b626761d487b45c170b115259f69d6b" 11:22:02 INFO - } 11:22:02 INFO - } 11:22:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 11:22:02 INFO - Running post-action listener: _resource_record_post_action 11:22:02 INFO - ##### 11:22:02 INFO - ##### Running download-and-extract step. 11:22:02 INFO - ##### 11:22:02 INFO - Running pre-action listener: _resource_record_pre_action 11:22:02 INFO - Running main action method: download_and_extract 11:22:02 INFO - mkdir: /builds/slave/test-pgo/build/tests 11:22: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')]} 11:22:02 INFO - https://queue.taskcluster.net/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:22:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/test_packages.json 11:22:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/test_packages.json 11:22:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 11:22:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 11:22:05 INFO - Downloaded 1302 bytes. 11:22:05 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 11:22:05 INFO - Using the following test package requirements: 11:22:05 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 11:22:05 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:22:05 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 11:22:05 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:22:05 INFO - u'jsshell-linux-x86_64.zip'], 11:22:05 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:22:05 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 11:22:05 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 11:22:05 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:22:05 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 11:22:05 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:22:05 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 11:22:05 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:22:05 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 11:22:05 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 11:22:05 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:22:05 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 11:22:05 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:22: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')]} 11:22:05 INFO - https://queue.taskcluster.net/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:22:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:22:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:22:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:22:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:22:06 INFO - Downloaded 21579043 bytes. 11:22:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 11:22:06 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:22:06 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 11:22:07 INFO - Return code: 0 11:22:07 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:22: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')]} 11:22:07 INFO - https://queue.taskcluster.net/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:22:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:22:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:22:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:22:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:22:09 INFO - Downloaded 21579043 bytes. 11:22:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 11:22:09 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:22:09 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 11:22:10 INFO - Return code: 0 11:22:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:10 INFO - https://queue.taskcluster.net/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:22:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 11:22:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 11:22:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 11:22:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:22:15 INFO - Downloaded 11132038 bytes. 11:22:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 11:22:15 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 11:22:15 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 11:22:15 INFO - Return code: 0 11:22: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')]} 11:22:15 INFO - https://queue.taskcluster.net/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:22:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 11:22:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 11:22:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 11:22:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:22:17 INFO - Downloaded 58070235 bytes. 11:22:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 11:22:17 INFO - mkdir: /builds/slave/test-pgo/properties 11:22:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 11:22:17 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 11:22:17 INFO - Contents: 11:22:17 INFO - build_url:https://queue.taskcluster.net/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 11:22:17 INFO - Running post-action listener: _resource_record_post_action 11:22:17 INFO - Running post-action listener: set_extra_try_arguments 11:22:17 INFO - ##### 11:22:17 INFO - ##### Running populate-webroot step. 11:22:17 INFO - ##### 11:22:17 INFO - Running pre-action listener: _resource_record_pre_action 11:22:17 INFO - Running main action method: populate_webroot 11:22:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:22:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:22:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:22:17 INFO - '--tppagecycles', 11:22:17 INFO - '7'], 11:22:17 INFO - 'tests': ['tsvgm']}}, 11:22:17 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:22:17 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:22:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:22:17 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:22:17 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:22:17 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:22:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:22:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:17 INFO - 'talos_options': ['--e10s'], 11:22:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:22:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:17 INFO - 'tests': ['damp', 'tps']}, 11:22:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:17 INFO - 'talos_options': ['--e10s'], 11:22:17 INFO - 'tests': ['damp', 'tps']}, 11:22:17 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:22:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:22:17 INFO - 'other': {'tests': ['a11yr', 11:22:17 INFO - 'ts_paint', 11:22:17 INFO - 'tpaint', 11:22:17 INFO - 'sessionrestore', 11:22:17 INFO - 'sessionrestore_no_auto_restore']}, 11:22:17 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:22:17 INFO - 'tests': ['a11yr', 11:22:17 INFO - 'ts_paint', 11:22:17 INFO - 'tpaint', 11:22:17 INFO - 'sessionrestore', 11:22:17 INFO - 'sessionrestore_no_auto_restore']}, 11:22:17 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:22:17 INFO - 'tests': ['a11yr', 11:22:17 INFO - 'ts_paint', 11:22:17 INFO - 'tpaint', 11:22:17 INFO - 'sessionrestore', 11:22:17 INFO - 'sessionrestore_no_auto_restore']}, 11:22:17 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:22:17 INFO - 'tests': ['a11yr', 11:22:17 INFO - 'ts_paint', 11:22:17 INFO - 'tpaint', 11:22:17 INFO - 'sessionrestore', 11:22:17 INFO - 'sessionrestore_no_auto_restore']}, 11:22:17 INFO - 'other_l64': {'tests': ['a11yr', 11:22:17 INFO - 'ts_paint', 11:22:17 INFO - 'tpaint', 11:22:17 INFO - 'sessionrestore', 11:22:17 INFO - 'sessionrestore_no_auto_restore']}, 11:22:17 INFO - 'other_nol64': {'tests': ['a11yr', 11:22:17 INFO - 'ts_paint', 11:22:17 INFO - 'tpaint', 11:22:17 INFO - 'sessionrestore', 11:22:17 INFO - 'sessionrestore_no_auto_restore']}, 11:22:17 INFO - 'svgr': {'tests': ['tsvgx', 11:22:17 INFO - 'tsvgr_opacity', 11:22:17 INFO - 'tart', 11:22:17 INFO - 'tscrollx', 11:22:17 INFO - 'cart']}, 11:22:17 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:22:17 INFO - 'tests': ['tsvgx', 11:22:17 INFO - 'tsvgr_opacity', 11:22:17 INFO - 'tart', 11:22:17 INFO - 'tscrollx', 11:22:17 INFO - 'cart']}, 11:22:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:17 INFO - 'tests': ['tp5o']}, 11:22:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:17 INFO - 'talos_options': ['--e10s'], 11:22:17 INFO - 'tests': ['tp5o']}, 11:22:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:17 INFO - 'talos_options': ['--xperf_path', 11:22:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:22:17 INFO - 'tests': ['tp5n']}, 11:22:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:17 INFO - 'talos_options': ['--e10s', 11:22:17 INFO - '--xperf_path', 11:22:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:22:17 INFO - 'tests': ['tp5n']}}, 11:22:17 INFO - 'talos.zip': {'path': '', 11:22:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:22:17 INFO - Running post-action listener: _resource_record_post_action 11:22:17 INFO - ##### 11:22:17 INFO - ##### Running create-virtualenv step. 11:22:17 INFO - ##### 11:22:17 INFO - Running pre-action listener: _resource_record_pre_action 11:22:17 INFO - Running main action method: create_virtualenv 11:22:17 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 11:22:17 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 11:22:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 11:22:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:22:17 INFO - Using real prefix '/usr' 11:22:17 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 11:22:17 INFO - Installing distribute.............................................................................................................................................................................................done. 11:22:19 INFO - Installing pip.................done. 11:22:19 INFO - Return code: 0 11:22:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 11:22:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:19 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 0x7fe0c4b1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf7d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fa50>, '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 0xf7b550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf7b9e0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1453749720.413366-2082337915', '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 11:22:19 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 11:22:19 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 11:22:19 INFO - Using env: {'DISPLAY': ':0', 11:22:19 INFO - 'HOME': '/home/cltbld', 11:22:19 INFO - 'LANG': 'en_US.UTF-8', 11:22:19 INFO - 'LANGUAGE': 'en_US:en', 11:22:19 INFO - 'LOGNAME': 'cltbld', 11:22:19 INFO - 'MAIL': '/var/mail/cltbld', 11:22:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:19 INFO - 'MOZ_NO_REMOTE': '1', 11:22:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:19 INFO - 'NO_EM_RESTART': '1', 11:22:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:22:19 INFO - 'PWD': '/builds/slave/test-pgo', 11:22:19 INFO - 'SHELL': '/bin/bash', 11:22:19 INFO - 'SHLVL': '1', 11:22:19 INFO - 'TERM': 'linux', 11:22:19 INFO - 'TMOUT': '86400', 11:22:19 INFO - 'USER': 'cltbld', 11:22:19 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1453749720.413366-2082337915', 11:22:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:19 INFO - '_': '/tools/buildbot/bin/python'} 11:22:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:20 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 11:22:20 INFO - Cleaning up... 11:22:20 INFO - Return code: 0 11:22:20 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 11:22:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:20 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 0x7fe0c4b1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf7d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fa50>, '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 0xf7b550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf7b9e0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1453749720.413366-2082337915', '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 11:22:20 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 11:22:20 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 11:22:20 INFO - Using env: {'DISPLAY': ':0', 11:22:20 INFO - 'HOME': '/home/cltbld', 11:22:20 INFO - 'LANG': 'en_US.UTF-8', 11:22:20 INFO - 'LANGUAGE': 'en_US:en', 11:22:20 INFO - 'LOGNAME': 'cltbld', 11:22:20 INFO - 'MAIL': '/var/mail/cltbld', 11:22:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:20 INFO - 'MOZ_NO_REMOTE': '1', 11:22:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:20 INFO - 'NO_EM_RESTART': '1', 11:22:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:22:20 INFO - 'PWD': '/builds/slave/test-pgo', 11:22:20 INFO - 'SHELL': '/bin/bash', 11:22:20 INFO - 'SHLVL': '1', 11:22:20 INFO - 'TERM': 'linux', 11:22:20 INFO - 'TMOUT': '86400', 11:22:20 INFO - 'USER': 'cltbld', 11:22:20 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1453749720.413366-2082337915', 11:22:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:20 INFO - '_': '/tools/buildbot/bin/python'} 11:22:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:20 INFO - Downloading/unpacking psutil>=0.7.1 11:22: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 11:22: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 11:22: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 11:22: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 11:22: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 11:22: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 11:22:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 11:22:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:22:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:22:22 INFO - Installing collected packages: psutil 11:22:22 INFO - Running setup.py install for psutil 11:22:22 INFO - building 'psutil._psutil_linux' extension 11:22:22 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 11:22:22 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 11:22:22 INFO - building 'psutil._psutil_posix' extension 11:22:22 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 11:22:22 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 11:22:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:22:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:22:22 INFO - Successfully installed psutil 11:22:22 INFO - Cleaning up... 11:22:22 INFO - Return code: 0 11:22:22 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 11:22:22 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')]} 11:22:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:22 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')]} 11:22:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:22 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 0x7fe0c4b1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf7d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fa50>, '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 0xf7b550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf7b9e0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1453749720.413366-2082337915', '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 11:22:22 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 11:22:22 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 11:22:22 INFO - Using env: {'DISPLAY': ':0', 11:22:22 INFO - 'HOME': '/home/cltbld', 11:22:22 INFO - 'LANG': 'en_US.UTF-8', 11:22:22 INFO - 'LANGUAGE': 'en_US:en', 11:22:22 INFO - 'LOGNAME': 'cltbld', 11:22:22 INFO - 'MAIL': '/var/mail/cltbld', 11:22:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:22 INFO - 'MOZ_NO_REMOTE': '1', 11:22:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:22 INFO - 'NO_EM_RESTART': '1', 11:22:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:22:22 INFO - 'PWD': '/builds/slave/test-pgo', 11:22:22 INFO - 'SHELL': '/bin/bash', 11:22:22 INFO - 'SHLVL': '1', 11:22:22 INFO - 'TERM': 'linux', 11:22:22 INFO - 'TMOUT': '86400', 11:22:22 INFO - 'USER': 'cltbld', 11:22:22 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1453749720.413366-2082337915', 11:22:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:22 INFO - '_': '/tools/buildbot/bin/python'} 11:22:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:22 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:22:22 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 11:22:22 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 11:22:22 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 11:22:22 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 11:22:22 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 11:22:22 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 11:22:24 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:22:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:22:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:22:24 INFO - Installing collected packages: mozsystemmonitor 11:22:24 INFO - Running setup.py install for mozsystemmonitor 11:22:24 INFO - Successfully installed mozsystemmonitor 11:22:24 INFO - Cleaning up... 11:22:24 INFO - Return code: 0 11:22:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 11:22:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:24 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe0c4b1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf7d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fa50>, '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 0xf7b550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf7b9e0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1453749720.413366-2082337915', '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 11:22:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 11:22:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:22:24 INFO - Using env: {'DISPLAY': ':0', 11:22:24 INFO - 'HOME': '/home/cltbld', 11:22:24 INFO - 'LANG': 'en_US.UTF-8', 11:22:24 INFO - 'LANGUAGE': 'en_US:en', 11:22:24 INFO - 'LOGNAME': 'cltbld', 11:22:24 INFO - 'MAIL': '/var/mail/cltbld', 11:22:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:24 INFO - 'MOZ_NO_REMOTE': '1', 11:22:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:24 INFO - 'NO_EM_RESTART': '1', 11:22:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:22:24 INFO - 'PWD': '/builds/slave/test-pgo', 11:22:24 INFO - 'SHELL': '/bin/bash', 11:22:24 INFO - 'SHLVL': '1', 11:22:24 INFO - 'TERM': 'linux', 11:22:24 INFO - 'TMOUT': '86400', 11:22:24 INFO - 'USER': 'cltbld', 11:22:24 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1453749720.413366-2082337915', 11:22:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:24 INFO - '_': '/tools/buildbot/bin/python'} 11:22:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:25 INFO - Downloading/unpacking blobuploader==1.2.4 11:22:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:26 INFO - Downloading blobuploader-1.2.4.tar.gz 11:22:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:22:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:22: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 11:22: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 11:22: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 11:22: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 11:22: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 11:22: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 11:22:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 11:22:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:22:27 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 11:22:27 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 11:22:27 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 11:22:27 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 11:22:27 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 11:22:27 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 11:22:27 INFO - Downloading docopt-0.6.1.tar.gz 11:22:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 11:22:27 INFO - Installing collected packages: blobuploader, requests, docopt 11:22:27 INFO - Running setup.py install for blobuploader 11:22:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:22:27 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 11:22:27 INFO - Running setup.py install for requests 11:22:27 INFO - Running setup.py install for docopt 11:22:28 INFO - Successfully installed blobuploader requests docopt 11:22:28 INFO - Cleaning up... 11:22:28 INFO - Return code: 0 11:22:28 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:22: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')]} 11:22:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22: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')]} 11:22:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:28 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 0x7fe0c4b1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf7d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fa50>, '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 0xf7b550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf7b9e0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1453749720.413366-2082337915', '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 11:22:28 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 11:22:28 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 11:22:28 INFO - Using env: {'DISPLAY': ':0', 11:22:28 INFO - 'HOME': '/home/cltbld', 11:22:28 INFO - 'LANG': 'en_US.UTF-8', 11:22:28 INFO - 'LANGUAGE': 'en_US:en', 11:22:28 INFO - 'LOGNAME': 'cltbld', 11:22:28 INFO - 'MAIL': '/var/mail/cltbld', 11:22:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:28 INFO - 'MOZ_NO_REMOTE': '1', 11:22:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:28 INFO - 'NO_EM_RESTART': '1', 11:22:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:22:28 INFO - 'PWD': '/builds/slave/test-pgo', 11:22:28 INFO - 'SHELL': '/bin/bash', 11:22:28 INFO - 'SHLVL': '1', 11:22:28 INFO - 'TERM': 'linux', 11:22:28 INFO - 'TMOUT': '86400', 11:22:28 INFO - 'USER': 'cltbld', 11:22:28 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1453749720.413366-2082337915', 11:22:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:28 INFO - '_': '/tools/buildbot/bin/python'} 11:22:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:22:28 INFO - Running setup.py (path:/tmp/pip-DqTPne-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:22:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:22:28 INFO - Running setup.py (path:/tmp/pip-p104ox-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:22:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:22:28 INFO - Running setup.py (path:/tmp/pip-EApweM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:22:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:22:28 INFO - Running setup.py (path:/tmp/pip-9Dq4tn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:22:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:22:28 INFO - Running setup.py (path:/tmp/pip-lUqOry-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:22:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:22:28 INFO - Running setup.py (path:/tmp/pip-ZVyhDh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:22:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:22:28 INFO - Running setup.py (path:/tmp/pip-FAnPdB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:22:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:22:28 INFO - Running setup.py (path:/tmp/pip-3_Uow2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:22:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:22:28 INFO - Running setup.py (path:/tmp/pip-XJIzRZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:22:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:22:29 INFO - Running setup.py (path:/tmp/pip-q01uv5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:22:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:22:29 INFO - Running setup.py (path:/tmp/pip-fMMtG3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:22:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:22:29 INFO - Running setup.py (path:/tmp/pip-wi6MGv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:22:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:22:29 INFO - Running setup.py (path:/tmp/pip-QKIAKv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:22:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:22:29 INFO - Running setup.py (path:/tmp/pip-PWpjTX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:22:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:22:29 INFO - Running setup.py (path:/tmp/pip-Q6PoK_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:22:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:22:29 INFO - Running setup.py (path:/tmp/pip-0E4eHk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:22:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:22:29 INFO - Running setup.py (path:/tmp/pip-v11EKn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:22:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:22:29 INFO - Running setup.py install for manifestparser 11:22:29 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 11:22:29 INFO - Running setup.py install for mozcrash 11:22:29 INFO - Running setup.py install for mozdebug 11:22:29 INFO - Running setup.py install for mozdevice 11:22:30 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 11:22:30 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 11:22:30 INFO - Running setup.py install for mozfile 11:22:30 INFO - Running setup.py install for mozhttpd 11:22:30 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 11:22:30 INFO - Running setup.py install for mozinfo 11:22:30 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 11:22:30 INFO - Running setup.py install for mozInstall 11:22:30 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 11:22:30 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 11:22:30 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 11:22:30 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 11:22:30 INFO - Running setup.py install for mozleak 11:22:30 INFO - Running setup.py install for mozlog 11:22:30 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 11:22:30 INFO - Running setup.py install for moznetwork 11:22:30 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 11:22:30 INFO - Running setup.py install for mozprocess 11:22:30 INFO - Running setup.py install for mozprofile 11:22:30 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 11:22:30 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 11:22:30 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 11:22:30 INFO - Running setup.py install for mozrunner 11:22:31 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 11:22:31 INFO - Running setup.py install for mozscreenshot 11:22:31 INFO - Running setup.py install for moztest 11:22:31 INFO - Running setup.py install for mozversion 11:22:31 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 11:22:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:22:31 INFO - Cleaning up... 11:22:31 INFO - Return code: 0 11:22:31 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:22: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')]} 11:22:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22: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')]} 11:22:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:31 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 0x7fe0c4b1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf7d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fa50>, '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 0xf7b550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf7b9e0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1453749720.413366-2082337915', '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 11:22:31 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 11:22:31 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 11:22:31 INFO - Using env: {'DISPLAY': ':0', 11:22:31 INFO - 'HOME': '/home/cltbld', 11:22:31 INFO - 'LANG': 'en_US.UTF-8', 11:22:31 INFO - 'LANGUAGE': 'en_US:en', 11:22:31 INFO - 'LOGNAME': 'cltbld', 11:22:31 INFO - 'MAIL': '/var/mail/cltbld', 11:22:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:31 INFO - 'MOZ_NO_REMOTE': '1', 11:22:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:31 INFO - 'NO_EM_RESTART': '1', 11:22:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:22:31 INFO - 'PWD': '/builds/slave/test-pgo', 11:22:31 INFO - 'SHELL': '/bin/bash', 11:22:31 INFO - 'SHLVL': '1', 11:22:31 INFO - 'TERM': 'linux', 11:22:31 INFO - 'TMOUT': '86400', 11:22:31 INFO - 'USER': 'cltbld', 11:22:31 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1453749720.413366-2082337915', 11:22:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:31 INFO - '_': '/tools/buildbot/bin/python'} 11:22:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:22:31 INFO - Running setup.py (path:/tmp/pip-pbqGJo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:22:31 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)) 11:22:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:22:31 INFO - Running setup.py (path:/tmp/pip-KeLxZj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:22:31 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)) 11:22:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:22:31 INFO - Running setup.py (path:/tmp/pip-mNYHbJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:22:31 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)) 11:22:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:22:31 INFO - Running setup.py (path:/tmp/pip-QcXtU5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:22:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 11:22:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:22:31 INFO - Running setup.py (path:/tmp/pip-vpkeHw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:22:31 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)) 11:22:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:22:31 INFO - Running setup.py (path:/tmp/pip-zuVKzF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:22:32 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)) 11:22:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:22:32 INFO - Running setup.py (path:/tmp/pip-kmd32K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:22:32 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)) 11:22:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:22:32 INFO - Running setup.py (path:/tmp/pip-9Awuwd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:22:32 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)) 11:22:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:22:32 INFO - Running setup.py (path:/tmp/pip-9qgGGC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:22:32 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)) 11:22:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:22:32 INFO - Running setup.py (path:/tmp/pip-P9wC5N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:22:32 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)) 11:22:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:22:32 INFO - Running setup.py (path:/tmp/pip-5CofFy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:22:32 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)) 11:22:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:22:32 INFO - Running setup.py (path:/tmp/pip-kdx4YL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:22:32 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)) 11:22:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:22:32 INFO - Running setup.py (path:/tmp/pip-pSdNs6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 11:22:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:22:32 INFO - Running setup.py (path:/tmp/pip-zBXfpR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:22:32 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)) 11:22:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:22:32 INFO - Running setup.py (path:/tmp/pip-pOR4Oo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:22:32 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)) 11:22:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:22:32 INFO - Running setup.py (path:/tmp/pip-GCBwkq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:22:32 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)) 11:22:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:22:32 INFO - Running setup.py (path:/tmp/pip-ZpLTjT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:22:32 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)) 11:22:32 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)) 11:22:32 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)) 11:22:32 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)) 11:22:32 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 11:22:32 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 11:22:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 11:22:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:34 INFO - Downloading blessings-1.6.tar.gz 11:22:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 11:22:34 INFO - Installing collected packages: blessings 11:22:34 INFO - Running setup.py install for blessings 11:22:34 INFO - Successfully installed blessings 11:22:34 INFO - Cleaning up... 11:22:34 INFO - Return code: 0 11:22:34 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 11:22:34 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:22:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:22:35 INFO - Reading from file tmpfile_stdout 11:22:35 INFO - Current package versions: 11:22:35 INFO - argparse == 1.2.1 11:22:35 INFO - blessings == 1.6 11:22:35 INFO - blobuploader == 1.2.4 11:22:35 INFO - docopt == 0.6.1 11:22:35 INFO - manifestparser == 1.1 11:22:35 INFO - mozInstall == 1.12 11:22:35 INFO - mozcrash == 0.16 11:22:35 INFO - mozdebug == 0.1 11:22:35 INFO - mozdevice == 0.47 11:22:35 INFO - mozfile == 1.2 11:22:35 INFO - mozhttpd == 0.7 11:22:35 INFO - mozinfo == 0.9 11:22:35 INFO - mozleak == 0.1 11:22:35 INFO - mozlog == 3.1 11:22:35 INFO - moznetwork == 0.27 11:22:35 INFO - mozprocess == 0.22 11:22:35 INFO - mozprofile == 0.27 11:22:35 INFO - mozrunner == 6.11 11:22:35 INFO - mozscreenshot == 0.1 11:22:35 INFO - mozsystemmonitor == 0.0 11:22:35 INFO - moztest == 0.7 11:22:35 INFO - mozversion == 1.4 11:22:35 INFO - psutil == 3.1.1 11:22:35 INFO - requests == 1.2.3 11:22:35 INFO - wsgiref == 0.1.2 11:22:35 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:22:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:35 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 0x7fe0c4b1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf7d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fa50>, '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 0xf7b550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf7b9e0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1453749720.413366-2082337915', '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 11:22:35 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 11:22:35 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 11:22:35 INFO - Using env: {'DISPLAY': ':0', 11:22:35 INFO - 'HOME': '/home/cltbld', 11:22:35 INFO - 'LANG': 'en_US.UTF-8', 11:22:35 INFO - 'LANGUAGE': 'en_US:en', 11:22:35 INFO - 'LOGNAME': 'cltbld', 11:22:35 INFO - 'MAIL': '/var/mail/cltbld', 11:22:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:35 INFO - 'MOZ_NO_REMOTE': '1', 11:22:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:35 INFO - 'NO_EM_RESTART': '1', 11:22:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:22:35 INFO - 'PWD': '/builds/slave/test-pgo', 11:22:35 INFO - 'SHELL': '/bin/bash', 11:22:35 INFO - 'SHLVL': '1', 11:22:35 INFO - 'TERM': 'linux', 11:22:35 INFO - 'TMOUT': '86400', 11:22:35 INFO - 'USER': 'cltbld', 11:22:35 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1453749720.413366-2082337915', 11:22:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:35 INFO - '_': '/tools/buildbot/bin/python'} 11:22:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:35 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 1)) 11:22:35 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 2)) 11:22:35 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 3)) 11:22:35 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 4)) 11:22:35 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 5)) 11:22:35 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 6)) 11:22:35 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 7)) 11:22:35 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 8)) 11:22:35 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.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 11:22:35 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 3)) 11:22:35 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.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 11:22:35 INFO - Cleaning up... 11:22:35 INFO - Return code: 0 11:22:35 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 11:22:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:35 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 0x7fe0c4b1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf7d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fa50>, '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 0xf7b550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf7b9e0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1453749720.413366-2082337915', '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 11:22:35 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 11:22:35 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 11:22:35 INFO - Using env: {'DISPLAY': ':0', 11:22:35 INFO - 'HOME': '/home/cltbld', 11:22:35 INFO - 'LANG': 'en_US.UTF-8', 11:22:35 INFO - 'LANGUAGE': 'en_US:en', 11:22:35 INFO - 'LOGNAME': 'cltbld', 11:22:35 INFO - 'MAIL': '/var/mail/cltbld', 11:22:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:35 INFO - 'MOZ_NO_REMOTE': '1', 11:22:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:35 INFO - 'NO_EM_RESTART': '1', 11:22:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:22:35 INFO - 'PWD': '/builds/slave/test-pgo', 11:22:35 INFO - 'SHELL': '/bin/bash', 11:22:35 INFO - 'SHLVL': '1', 11:22:35 INFO - 'TERM': 'linux', 11:22:35 INFO - 'TMOUT': '86400', 11:22:35 INFO - 'USER': 'cltbld', 11:22:35 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1453749720.413366-2082337915', 11:22:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:35 INFO - '_': '/tools/buildbot/bin/python'} 11:22:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:35 INFO - Downloading/unpacking jsonschema 11:22:35 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 11:22:35 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 11:22:35 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 11:22:35 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 11:22:35 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 11:22:35 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 11:22:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:22:37 INFO - Downloading/unpacking functools32 (from jsonschema) 11:22:37 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 11:22:37 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 11:22:37 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 11:22:37 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 11:22:37 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 11:22:37 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 11:22:37 INFO - Downloading functools32-3.2.3-2.tar.gz 11:22:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 11:22:37 INFO - warning: no files found matching '*.txt' 11:22:37 INFO - no previously-included directories found matching 'build' 11:22:37 INFO - no previously-included directories found matching 'dist' 11:22:37 INFO - no previously-included directories found matching '.git*' 11:22:37 INFO - Installing collected packages: jsonschema, functools32 11:22:37 INFO - Running setup.py install for functools32 11:22:37 INFO - warning: no files found matching '*.txt' 11:22:37 INFO - no previously-included directories found matching 'build' 11:22:37 INFO - no previously-included directories found matching 'dist' 11:22:37 INFO - no previously-included directories found matching '.git*' 11:22:37 INFO - Successfully installed jsonschema functools32 11:22:37 INFO - Cleaning up... 11:22:37 INFO - Return code: 0 11:22:37 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 11:22:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:37 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 0x7fe0c4b1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf7d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fa50>, '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 0xf7b550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf7b9e0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1453749720.413366-2082337915', '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 11:22:37 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 11:22:37 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 11:22:37 INFO - Using env: {'DISPLAY': ':0', 11:22:37 INFO - 'HOME': '/home/cltbld', 11:22:37 INFO - 'LANG': 'en_US.UTF-8', 11:22:37 INFO - 'LANGUAGE': 'en_US:en', 11:22:37 INFO - 'LOGNAME': 'cltbld', 11:22:37 INFO - 'MAIL': '/var/mail/cltbld', 11:22:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:37 INFO - 'MOZ_NO_REMOTE': '1', 11:22:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:37 INFO - 'NO_EM_RESTART': '1', 11:22:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:22:37 INFO - 'PWD': '/builds/slave/test-pgo', 11:22:37 INFO - 'SHELL': '/bin/bash', 11:22:37 INFO - 'SHLVL': '1', 11:22:37 INFO - 'TERM': 'linux', 11:22:37 INFO - 'TMOUT': '86400', 11:22:37 INFO - 'USER': 'cltbld', 11:22:37 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1453749720.413366-2082337915', 11:22:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:37 INFO - '_': '/tools/buildbot/bin/python'} 11:22:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:37 INFO - Downloading/unpacking flake8 11:22:37 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 11:22:37 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 11:22:37 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 11:22:37 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 11:22:37 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 11:22:37 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 11:22:39 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:22:39 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:22:39 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 11:22:39 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 11:22:39 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 11:22:39 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 11:22:39 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 11:22:39 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 11:22:39 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:22:39 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:22:39 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 11:22:39 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 11:22:39 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 11:22:39 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 11:22:39 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 11:22:39 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 11:22:40 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:22:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 11:22:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:22:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:22:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:22:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:22:40 INFO - no previously-included directories found matching 'docs/_build' 11:22:40 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:22:40 INFO - Running setup.py install for pep8 11:22:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:22:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:22:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:22:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:22:40 INFO - no previously-included directories found matching 'docs/_build' 11:22:40 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 11:22:40 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:22:40 INFO - Cleaning up... 11:22:40 INFO - Return code: 0 11:22:40 INFO - Running post-action listener: _resource_record_post_action 11:22:40 INFO - Running post-action listener: _start_resource_monitoring 11:22:40 INFO - Starting resource monitoring. 11:22:40 INFO - ##### 11:22:40 INFO - ##### Running install step. 11:22:40 INFO - ##### 11:22:40 INFO - Running pre-action listener: _resource_record_pre_action 11:22:40 INFO - Running main action method: install 11:22:40 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:22:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:22:40 INFO - Reading from file tmpfile_stdout 11:22:40 INFO - Detecting whether we're running mozinstall >=1.0... 11:22:40 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 11:22:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 11:22:40 INFO - Reading from file tmpfile_stdout 11:22:40 INFO - Output received: 11:22:40 INFO - Usage: mozinstall [options] installer 11:22:40 INFO - Options: 11:22:40 INFO - -h, --help show this help message and exit 11:22:40 INFO - -d DEST, --destination=DEST 11:22:40 INFO - Directory to install application into. [default: 11:22:40 INFO - "/builds/slave/test-pgo"] 11:22:40 INFO - --app=APP Application being installed. [default: firefox] 11:22:40 INFO - mkdir: /builds/slave/test-pgo/build/application 11:22:40 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 11:22:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 11:22:55 INFO - Reading from file tmpfile_stdout 11:22:55 INFO - Output received: 11:22:55 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 11:22:55 INFO - Running post-action listener: _resource_record_post_action 11:22:55 INFO - ##### 11:22:55 INFO - ##### Running run-tests step. 11:22:55 INFO - ##### 11:22:55 INFO - Running pre-action listener: _resource_record_pre_action 11:22:55 INFO - Running main action method: run_tests 11:22:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 11:22:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 11:22:55 INFO - Python 2.7.3 11:22:55 INFO - Return code: 0 11:22:55 INFO - grabbing minidump binary from tooltool 11:22:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:55 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 0x100fa50>, '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 0xf7b550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf7b9e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 11:22:55 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 11:22:55 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 11:22:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:22:55 INFO - Return code: 0 11:22:55 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 11:22:55 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 11:22:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 11:22:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 11:22:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 11:22:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 11:22:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 11:22:56 INFO - Return code: 0 11:22:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 11:22:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --webServer localhost 11:22:56 INFO - Using env: {'DISPLAY': ':0', 11:22:56 INFO - 'HOME': '/home/cltbld', 11:22:56 INFO - 'LANG': 'en_US.UTF-8', 11:22:56 INFO - 'LANGUAGE': 'en_US:en', 11:22:56 INFO - 'LOGNAME': 'cltbld', 11:22:56 INFO - 'MAIL': '/var/mail/cltbld', 11:22:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:22:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 11:22:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:56 INFO - 'MOZ_NO_REMOTE': '1', 11:22:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:22:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:56 INFO - 'NO_EM_RESTART': '1', 11:22:56 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:22:56 INFO - 'PWD': '/builds/slave/test-pgo', 11:22:56 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 11:22:56 INFO - 'SHELL': '/bin/bash', 11:22:56 INFO - 'SHLVL': '1', 11:22:56 INFO - 'TERM': 'linux', 11:22:56 INFO - 'TMOUT': '86400', 11:22:56 INFO - 'USER': 'cltbld', 11:22:56 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1453749720.413366-2082337915', 11:22:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:56 INFO - '_': '/tools/buildbot/bin/python'} 11:22:56 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost'] with output_timeout 3600 11:22:56 INFO - mozversion INFO | application_buildid: 20160125032407 11:22:56 INFO - mozversion INFO | application_changeset: 3bfa5bc61b626761d487b45c170b115259f69d6b 11:22:56 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 11:22:56 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:22:56 INFO - mozversion INFO | application_name: Firefox 11:22:56 INFO - mozversion INFO | application_remotingname: firefox-dev 11:22:56 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:22:56 INFO - mozversion INFO | application_vendor: Mozilla 11:22:56 INFO - mozversion INFO | application_version: 45.0a2 11:22:56 INFO - mozversion INFO | platform_buildid: 20160125032407 11:22:56 INFO - mozversion INFO | platform_changeset: 3bfa5bc61b626761d487b45c170b115259f69d6b 11:22:56 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:22:56 INFO - mozversion INFO | platform_version: 45.0a2 11:22:56 INFO - 2016-01-25 11:22:56,769 DEBUG : using testdate: 1453749776 11:22:56 INFO - 2016-01-25 11:22:56,769 DEBUG : actual date: 1453749776 11:22:56 INFO - 2016-01-25 11:22:56,777 INFO : starting webserver on 'localhost:34845' 11:22:56 INFO - 2016-01-25 11:22:56,778 INFO : Starting test suite talos-linux64-ix-051.e 11:22:56 INFO - 2016-01-25 11:22:56,778 INFO : Starting test dromaeo_css 11:22:56 INFO - 2016-01-25 11:22:56,778 DEBUG : operating with platform_type : linux_ 11:22:56 INFO - 2016-01-25 11:22:56,778 INFO : Initialising browser for dromaeo_css test... 11:22:56 INFO - 2016-01-25 11:22:56,785 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXG5YaP/profile http://localhost:34845/getInfo.html 11:23:00 INFO - 2016-01-25 11:23:00,118 DEBUG : BROWSER_OUTPUT: 11:23:00 INFO - 2016-01-25 11:23:00,119 DEBUG : BROWSER_OUTPUT: (process:26652): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:23:00 INFO - 2016-01-25 11:23:00,982 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:23:00 INFO - 2016-01-25 11:23:00,982 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:23:00 INFO - 2016-01-25 11:23:00,982 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:23:00 INFO - 2016-01-25 11:23:00,982 DEBUG : BROWSER_OUTPUT: __metrics 11:23:01 INFO - 2016-01-25 11:23:01,889 INFO : Browser initialized. 11:23:01 INFO - 2016-01-25 11:23:01,890 INFO : Running cycle 1/1 for dromaeo_css test... 11:23:01 INFO - 2016-01-25 11:23:01,890 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXG5YaP/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:23:03 INFO - 2016-01-25 11:23:03,140 DEBUG : BROWSER_OUTPUT: 11:23:03 INFO - 2016-01-25 11:23:03,140 DEBUG : BROWSER_OUTPUT: (process:26764): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:23:13 INFO - 2016-01-25 11:23:13,645 DEBUG : BROWSER_OUTPUT: RSS: Main: 138330112 11:23:13 INFO - 2016-01-25 11:23:13,646 DEBUG : BROWSER_OUTPUT: 11:24:03 INFO - 2016-01-25 11:24:03,245 DEBUG : BROWSER_OUTPUT: 1453749843243 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] 11:26:11 INFO - 2016-01-25 11:26:11,037 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34845/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34845/tests/dromaeo/cssquery-ext.html) 11:26:12 INFO - 2016-01-25 11:26:12,369 DEBUG : BROWSER_OUTPUT: RSS: Main: 140914688 11:26:12 INFO - 2016-01-25 11:26:12,369 DEBUG : BROWSER_OUTPUT: 11:29:14 INFO - 2016-01-25 11:29:14,214 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34845/tests/dromaeo/cssquery-ext.html (next: http://localhost:34845/tests/dromaeo/cssquery-jquery.html) 11:29:14 INFO - 2016-01-25 11:29:14,803 DEBUG : BROWSER_OUTPUT: RSS: Main: 139526144 11:29:14 INFO - 2016-01-25 11:29:14,803 DEBUG : BROWSER_OUTPUT: 11:32:16 INFO - 2016-01-25 11:32:16,401 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34845/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34845/tests/dromaeo/cssquery-mootools.html) 11:32:16 INFO - 2016-01-25 11:32:16,988 DEBUG : BROWSER_OUTPUT: RSS: Main: 139804672 11:32:16 INFO - 2016-01-25 11:32:16,988 DEBUG : BROWSER_OUTPUT: 11:35:18 INFO - 2016-01-25 11:35:18,586 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34845/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34845/tests/dromaeo/cssquery-prototype.html) 11:35:19 INFO - 2016-01-25 11:35:19,180 DEBUG : BROWSER_OUTPUT: RSS: Main: 138862592 11:35:19 INFO - 2016-01-25 11:35:19,180 DEBUG : BROWSER_OUTPUT: 11:38:21 INFO - 2016-01-25 11:38:21,420 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34845/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34845/tests/dromaeo/cssquery-yui.html) 11:38:22 INFO - 2016-01-25 11:38:22,001 DEBUG : BROWSER_OUTPUT: RSS: Main: 139288576 11:38:22 INFO - 2016-01-25 11:38:22,002 DEBUG : BROWSER_OUTPUT: 11:41:24 INFO - 2016-01-25 11:41:24,093 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34845/tests/dromaeo/cssquery-yui.html (next: http://localhost:34845/tests/dromaeo/cssquery-dojo.html) 11:41:24 INFO - 2016-01-25 11:41:24,344 DEBUG : BROWSER_OUTPUT: RSS: Main: 141000704 11:41:24 INFO - 2016-01-25 11:41:24,344 DEBUG : BROWSER_OUTPUT: 11:41:24 INFO - 2016-01-25 11:41:24,344 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:41:24 INFO - 2016-01-25 11:41:24,344 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:41:24 INFO - 2016-01-25 11:41:24,344 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:41:24 INFO - 2016-01-25 11:41:24,344 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:41:24 INFO - 2016-01-25 11:41:24,345 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3234.45014347561;3261.853216605254;3290.2761392493644;3298.5052242163674;3299.4555898276785;5504.669719816814;5505.174223866412;5528.198411230369;5534.280543529336;5535.308086489189;5522.944770552293;5543.861403464905;5573.916391254134;5590.273264475612;5614.691191984439;5050.924236136461;5088.18589025756;5148.948510514884;5166.354205724285;5177.223416487519;4921.064997650435;5064.848054558351;5067.93573349597;5091.109055915219;5203.817866374678;5090.363704536933;5149.124648809692;5149.613778966574;5150.819721309755;5157.3811142662935;5094.286799848006;5148.819791307286;5185.585153187736;5204.323437953042;5228.241904923784;4888.242322440027;4917.459079501252;4976.377952755905;5011.498850114996;5084.389873215201;5366.597505187087;5392.379876314235;5402.189671549299;5426.484483974016;5433.864153396157;5932.991391463462;5975.790847320366;5993.9400605993815;5996.880062398771;6000.459958603703;5692.5161361284345;5859.091840764689;5865.237519122486;5945.643261404286;5971.790987315467;5604.131359639263;5608.6073974821775;5642.210090587321;5648.54811615074;5650.971745141248;5946.67293298864;6158.876822463526;6161.907571386433;6164.229471316085;6164.907526387108;5814.622049566765;5814.651120932757;5822.155787410802;5822.941770582324;5826.82519524415;5820.068788993825;5857.531397488191;5864.970675146682;5878.617889837147;5885.529157667376;5850.385709500526;5873.559483038789;5913.408659134052;5921.319048309413;5943.821685349447;5667.319921609434;5762.510186634183;5890.057590785539;5895.322037965603;5933.851653708692;4574.748388838646;4642.094791515689;4644.187267228222;4647.209974304376;4665.976670116627;4119.629233369011;4126.566710495415;4126.958730412717;4137.731047481904;4165.062860856283;5486.067368547357;5584.636998595079;5622.57830662702;5758.798442054592;5766.192733017381;6029.306629737636;6033.879322413527;6039.66781826995;6043.546733994968;6052.727627256696;5706.429357064343;5711.400302968212;5714.085746280575;5730.19777231188;5744.224529688522;5078.415982162099;5137.871553211125;5200.583953283728;5224.111900976843;5308.150695888639;6112.51099912006;6128.080787881764;6129.938700613026;6136.417040381157;6161.168242287324;5926.911096333644;5955.642661440327;6011.6693581853415;6030.336662967158;6050.878982420239;6003.759849605967;6070.666113363807;6091.42131497507;6109.450149486567;6200.162977998093;5881.852953676193;5931.851703707442;5969.8806023878415;5971.970140149271;6003.099535069775;6039.969800150971;6045;6057.242844644419;6060.454559089703;6063.484603808725;5649.180868773922;5694.943050569441;5760.193572899713;5762.711864406847;5928.199693041384;5793.94206057934;5796.594238403271;5814.592978491465;5855;5867.178594996619;5771.932192544393;5780.5953583248765;5781.739821708117;5804.042333015174;5820.097884827858;5583.050881350099;5677.858053548694;5890.646561206341;5893.381194974638;5922.993091174424;5735.197072409783;5779.046457334661;5806.5645076618575;5807.0998995155815;5832.591718579659 11:41:24 INFO - 2016-01-25 11:41:24,347 DEBUG : BROWSER_OUTPUT: |1;ext.html;578.1558923971002;632.8892443822332;644.8516841126541;649.1236830279126;660.9074729537863;37543.81228093859;37874.8106259469;38095.809520952425;38308.99999999996;38355.616443835555;44664;45717;45726;45793.771031144795;45921.31118033232;8957;9027.638894444215;9086.091390860927;9089.181973622373;9103.908960910405;8900.065493123226;8932.062133475956;8973;8983.19151276385;9008.234300084468;9097;9193.95403022984;9205.907940920571;9206.539673016356;9215.308851836138;8957.731268062002;8999.415038022507;9010.909890901139;9020.639174433014;9060.592273347682;8945.239654629364;9048.049954754788;9049.728508144766;9063.909360906438;9077.455352678795;40937.18125637471;41411;41422.37866432006;41470;41551.7922410389;3646.307201631708;3656.4332528457867;3788.677962373202;3834.2331533693373;4272.764997925113;30170.396592068035;30753.846230768926;31057;31150.532742008887;31438.528422073687;3607.9278414431565;3612.6929211017095;3639.290338384016;3663;3723.0506220913494;298804;299462;300992;301383.9999999978;301421;44637;45250.54749452463;45415.31877021847;67305;67705;43678.563214368085;43693.12613747707;43809.56190438118;43826;43834;15741.44904928322;15761.054336739602;15809.604759880865;15811.209439528207;15823.525294241192;12757.744845103047;12821.935890320488;12828.743425131444;12870.67823304425;12920.289384083777;15054.247287635575;15086.849131508545;15254.542363729106;15312.846871531143;15373.461928832437;6171.59884607499;6182.752689892444;6230.6884655767935;6245.657183705525;6269.025257044016;1032.2413026425572;1095.4139535348709;1122.2088427658482;1124.707576030238;1146.6846617180342;34420.48369274463;34977;35088.64911350905;35151.4727279091;35190.824045879606;1148.8563929508812;1155.8035134027236;1160.3270103340042;1176.7764124816258;1210.062201793617;14951.102933824006;15181.772273415907;15242.618934526503;17413.3034678614;17901.7314740279;541738;548266;548390;549810;834768;59278.70360648169;59492;59854.70072649609;59963.70018149881;60138.699306503186;1455.3087283540444;1485.9925700371646;1494.275276490901;1496.2219645784132;1499.3552772307794;30874.53688194724;31238.15007097596;31297.687023129478;31480.212994675316;31745.20636984094;49783;50052.499475004784;50121;50153.498465016346;50501.49498505115;314782;315929;316345;318127;318295;34382.14044648804;34396.48405273973;34411.4838277421;34434.139146521535;34636.30727385489;55118.44881551294;55522;55543;55547;56083;37053.81473092617;38350.23299533938;39005.414918776805;39432.40851387289;39950.40074398944;39578.802105990435;39883;39903.2019359617;40231;40276.597234027286;38895.222095557365;39098.609013909496;39296.60703392929;39299.80350098346;39399.60600394074;33618.831905840314;34367.14082147966;34567.135821604665;38762.418563721;39955.200895982496;26370.868145659148;26447.206583802516;26557;26676.333091672863;26847.597286041117 11:41:24 INFO - 2016-01-25 11:41:24,350 DEBUG : BROWSER_OUTPUT: |2;jquery.html;383.08824996508304;384.7576027102925;387.56399051067547;389.60260534255076;390.2682470368059;16152;17025.91487042563;17443.302267909283;20336.796632033656;20393.286234981777;11872.347020913847;12064.336461494615;12872.485100595964;16570.502884913443;16582.419615313465;4845.515448455153;4970.204767237243;4975.626827987898;5074.416442109149;5536.114221724505;5390.757415916273;5457.972710136443;5550.16747487878;5558.527525160366;5571.331440227158;5484.287042684446;5485.369182544018;5591.944080559203;6118.235220597426;6173.135760993465;6151.569390142692;6159.106929495243;6167;6189.319174890758;6190.442860142563;5453.3728621208675;5525.11598144299;5548.611597188198;5552.583556233299;5620.437956204388;13553.119047261896;13947.721045579134;16009.519714408587;21965.780342196533;21985.340439786833;2240.943976400603;2258.9322320330416;2296.391456264091;2329.4758679297192;2528.8609126498036;10349.74125646865;10509.84235236472;10541.789164216672;10668.94665526675;10696.197785166143;1863.897485638303;1886.6321067391864;1929.8359639430525;1953.794851540582;1999.3701983875033;65168.67415662891;65419.67290163566;66484;67473.66263168702;67750.32249677539;10786.568537258421;10902.672919812418;10923.726906827234;10965.067969222706;10980.341179529094;14279.64300892486;14329.85670143306;14421.35103920326;14465.638359041108;14621;8256.174382561816;8307.335413166933;8309.37679674027;8440.029396619344;8453.112423195598;8143.429959902868;8189.426740128253;8208.876866847002;8222.095569487352;8235.8352832943;4398.626116780046;4576.107659006462;4600.7469589172915;4683.110209060268;4815.2054910939305;1928.9228430862888;1968.6653268944315;1981.4154824326858;1992.551675872946;1994.4415563642203;917.4495302818256;1124.2018167101287;1128.2835399521364;1138.5957984915235;1155.364549497773;15295;17384.65230695379;17629.765916385986;17631.294748209926;18327;971.4608392342177;998.6854140945579;1014.325473560089;1054.0408228512017;1056.793925184597;6404.839879003062;10185.236107291983;10395.532201050972;10649.467526623794;10999.450027498753;414389;420696;445153;445789;695667;88661.4535418589;91902;93527.53236233775;93555;94387;518.1243698150114;521.6635270250667;525.9868503287372;527.9736013199324;532.9360476742816;11147.554097835995;11159.888401115884;11370.602028928948;11382.658520244406;11441.027512661518;40073.398899015956;40626;40756.388654170805;41427.58572414237;41639.16721665489;52890;54003.45996540142;54586;56948.71525642345;60465;10302.690919272434;10436.165106791286;10448.68653940383;10454.42500662471;10455.895441045492;13877.930610346884;14665.56003319902;17969.820301796815;18878.622427551098;18920.43238702841;15855.286512107214;15947.44183953556;16129.435469758502;16325.755113673542;16572.50282491527;15888;15893.28480218416;16034.919825400799;16102.275397606902;16243.187840608158;16225.18874056316;16275.18624068768;16442.260098295843;16483.83516164871;16830.242639081025;10480.266381353536;10635.20235982289;10690.946545267223;10768.300060496043;10768.492411062301;12849.421776019915;16036;16096.758548622014;16198.271077801292;16212.756808648115 11:41:24 INFO - 2016-01-25 11:41:24,352 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1494.940202391904;1579.6129948162697;1625.6179797747534;1768.9203985820636;1873.9718904216438;7754.302112809846;7873.80315492113;8008.27925486706;8076.555789431579;8130.878036829445;7847.332976696974;7926.048874135097;7933.087694915086;7962.084360298553;7984.520928744279;2274.4200228941636;2311.572359113561;2315.583195024895;2322.779335963081;2324.1633012115626;2224.8665080095166;2255.0979608156704;2268.4442311633675;2270.795628393444;2288.1190741564533;2254.1546919905036;2274.73840508342;2278.5898538263104;2307.4231442139467;2322.280093171122;2251.594712951668;2280.0423821994636;2328.161861729776;2328.429534763985;2335.719713634366;2307.284741730069;2314.132200424841;2337.8012868905994;2338.275134708246;2345.4839935214227;7662.4253181011645;7747.30274275318;7759.068911730572;7780;7794.766157015299;4563.794629241692;4626.930596041062;4656.813727450898;4672.252439609646;4684;3009.2176034231256;3034.089773068071;3110.3623757129735;3113.579666744983;3120.547520609499;998.0418797953973;1001.2940876681995;1714.8885322454125;1757.2356025129109;1844.2622950819646;10595.523201455953;10670.679879603624;10679.466026698634;10692.144628429707;10716.303440276357;4022.6379625833815;4043.8180281887385;4044.4944381952255;4076.2458945095254;4104.507459104927;8792.60433280504;8859.424137431175;8864.601092950832;8887.466751994902;8895.822083558292;4656.3946686930485;4662.580367766917;4664.230401983703;4664.743439110882;4673.439187297546;4273.081287523135;4315.525292217853;4342.869713908588;4371.540988196193;4374.846880359172;3440.4323286657423;3463.7575369723877;3475.6871881530783;3495.650434956535;3504.0188747150837;1037.8287582548946;1048.8741351037925;1052.7315534538798;1056.4031322302874;1159.171192597297;1131.5417256011328;1134.7787181499527;1137.9658610241706;1139.8176291793272;1166.2652528906735;7207.279272072751;7522.360599349007;7555.73554925586;7566.621668916532;7594.31651151399;1166.690826930864;1181.4506254591656;1195.3664557784389;1196.646989138189;1197.9161458697981;6036.215292012011;6075.392460753889;6116.052011938068;6116.143739876421;6130.356312587203;9042.593083311267;9550.426974381558;9596.616135354509;9617.615295388247;9633.807323853483;9488;9535.761605959906;9541.666041688508;9551.808963820684;9643.180329671915;7228.96385518069;7465.06686664167;7487.588182649898;7516.962415187889;7517.548947063194;7081.044059051962;7337.413006959324;7351.228121047427;7367.189609143097;7388.963055184689;8445;8559.443636163629;8573.699920502753;8605.096464871349;8627.82744345097;8513.276371508491;8636.438631488933;8647.913520864962;8667.4366166199;8713.433626814236;6885.139357580302;6914.274001229798;6967.616781076887;6974.895376569457;6984.895226571707;7628.923710763043;7701.3068823806125;7769.184235655175;7771.339436147765;7772.494787838772;6926.134233220848;7414.184439711519;7446.7021319146625;7509;7545.434092442979;6929.376356127771;7050.823729406806;7129.572225666477;7148.106486689164;7226.674799633924;7170.67731952053;7203.387712044535;7210.387117095106;7213.819654508679;7250.927490725026;6494.545381823416;6521.673916304071;6553.344665533408;6560.44236239925;6570;6601.141851559267;6689.364510371507;6754.223264324469;6806.795796125926;6806.7957961261245 11:41:24 INFO - 2016-01-25 11:41:24,355 DEBUG : BROWSER_OUTPUT: |4;prototype.html;356.60416937199705;362.72614176296906;364.34054361605513;365.32050386281514;366.8972687647458;6309.053641953709;6393.488520918327;6403.167588213531;6463.83840403989;6466.256380516242;6284.780032698856;6300.810975670737;6365.363463653633;6396.072569477423;6414.166158399413;4877;4940.4318503372215;4945.703257804535;4947.628927830409;4960.925586116211;4916.754162291889;4933.876653083684;4940.555350018498;4946.5795407390415;4948.430930443009;4659.836905708301;4807.158747219222;4814.63890208234;4820.349252850873;4831.782569784368;4856.587190088847;4856.902861942742;4857.587105096071;4865.537773911473;4879;4237.894052648678;4240.660747140252;4244.08752118293;4250.468691413574;4252.596003379674;5969;6037.63774173551;6049.606775559574;6053.8183854484;6060.969695151496;5653.604247702662;5657.8019769307875;5657.830265092054;5664.773409063632;5665.263515742969;6709.228438729511;6738.427233685143;6738.629375384352;6743.426808721265;6768.289329620417;4681.180793361183;4698.953010469886;4707.741074240916;4708.270218116163;4709.340692303081;6951.826204344881;7019.5788252705;7092.361687448154;7097.89353159703;7102.644867756643;4721.622270218374;4722.527747225318;4723.220668589713;4729.6452766042685;4737.976310118427;4801.135795556834;4802.231642937113;4806.95193048072;4807.086653535887;4808.206645903387;5496.697681627549;5583.441655834466;5586.413426590231;5592.636478628876;5595.440455954372;6807.5575087619145;6812.284710105467;6813;6814.897776533356;6824.692888819915;1650.917454127289;1718.527404963645;1721.0878234535717;1722.3455087066834;1722.371334462912;1131.7227279316621;1136.7442325476702;1140.8003599370077;1146.7419830538229;1149.3965668024355;6461.515386346043;6519.348065193538;6552.148220731275;6553.770618028346;6565.868682626321;6985.720571177198;7014.158301003912;7014.22843487216;7016.824579385454;7022.719091236396;6388.776392826228;6478.157839480931;6482.643454610042;6520.641364724891;6548.738050477928;3792.639699228569;3812.4281357796553;3830.19565891166;3832.559255685576;3833.7316387852584;7197.748078817216;7223.133224013152;7229.638518074075;7238.927610723826;7242.45681573884;7078.292170782881;7173.246809085075;7204.603746793977;7206.675699593426;7305.5981920994855;7348.375388091965;7352.04423424962;7366.926330736624;7370.44721645868;7370.668319925616;7129.394001509722;7137.500374973702;7148.85702285941;7154.570725756471;7155.785326440215;6856.348646878539;7000.334968178015;7011.859762804817;7021.1574611047;7044.225135235018;7240.420766338786;7274.599897005715;7308.5614863108385;7336.7432139874845;7342.706291748484;4737.526247375235;4768.904621907473;4774.928376074431;4777.211760059551;4778.04439112172;6894.551854129466;6970.581765093908;7055.506114571931;7145.4998150128995;7149.034880291094;6776.254611992578;6895.4138898194215;6927.272636373108;6942.930570694229;6945.687444064928;6877.243503214742;6894.413974812197;6902.8619427612175;6912.066870972354;6923.826904327432;6652.168478940132;6708.765193218214;6771.153605799275;6782.084418603426;6783.253842077466;6880.518363714492;6949.7567585134275;6965.477589180933;6967.616781077089;6968.616726080114;6670.199576050905;6757.391834734701;6759.864802704017;6762.222344430256;6764.86470270582 11:41:24 INFO - 2016-01-25 11:41:24,355 DEBUG : BROWSER_OUTPUT: |5;yui.html;827.2843989948697;854.209855883308;889.0131953531579;914.2685851318943;916.5325683901212;14663.486777962773;14720.77918831217;14774.261286935636;14820.258987050645;14900.403983840646;12752;14306.141631502118;14334.784978225334;14373.137611743303;14401.711965760678;903.1735961595149;910.4218821048615;914.8856392950881;915.1809130827938;916.225789208118;910.4992254260163;913.6665117232229;920.894097178823;921.1433366968716;923.9445633261993;970.2383628851353;970.7621632699999;973.4062222044547;978.1196922769493;978.4373984958642;968.1528662420383;971.640493017581;972.5866506734609;973.8831340239146;976.2531663277598;709.8651256261345;715.1275443958363;719.4316489972967;719.5790462579397;720.7585458871284;14479.78280325796;14483.493077742229;14570.271486425743;14603.70792584153;14612.926935365254;12914.547990820276;13095.803562946563;13118.344082795822;13718.588442346745;14204;10050.547725352377;11572.652820415316;11719.296842189411;11826.645200643994;12111.818322725167;3886.24218277436;3939.2515422069714;3966.186931678999;4033.092554175287;4085.305498065336;47416;48303.27545086826;48727.269090964015;48811.267830982564;53935;10790.51442685081;10938.56245750161;10953.726156845983;11061.834072488919;11253.268537545033;19208.903955480135;19291.4212573623;19301.61396772085;19307.131179096974;19384.321548745727;7796.571188584682;8166.591670416456;8255.545944972964;8300.460470069425;8461.915380846112;4669.929951050737;4688.57802797743;4752.904941901143;4799.3760811094335;4811.879703007453;3238.8380580970856;3299.6700329967293;3389.254364039907;3470.340635279289;3477.009052420048;596.150485558078;613.5950272819917;616.3528295289927;620.4416025577017;628.5788521690479;720.1574158234878;721.3760097515716;734.203389322591;758.9316961473494;760.3536993555433;9075.092490751003;9252.629894804133;9345.112214339626;9394.906050939404;9536.475493847905;701.4528667639249;709.3686618909175;724.6920058974914;733.4609062339176;738.5162718419443;4395.912081758347;4396.988692600719;4403.251447253974;4487.64098872096;4582.1293954148605;58551.70724146352;61423.6928815362;61710;61887;62138.37861621326;47981.280280795814;48923;53327;54536;54785.45214547803;52780.47219527756;53375;54384;55008;55865.44134558603;8982.281417486716;9069.682561110329;9507.809843803223;9824.4105353679;9836.311458197857;37069.81465092657;38195.236095278495;38296.61703383042;38769.6123038766;39377.80311098426;44164.55835441733;46157.30764038475;49419.50580494293;49833.75083124561;49862;11250;11531.596394126165;11721.941390292994;12260.325682087214;12356.073294502768;12016.519339226683;12438.129330946747;12590;12693.746125077632;13281.402336895057;11824.40877956116;12434.502619895466;12531.624051278111;12606.243625382507;13172.143810652276;11568.537258509565;11571.247868888495;11692.766144676889;11835.644930652094;12274.324912129918;12151.088668350087;12294.077944154045;12374.81437778452;12650.177738446971;12704.74590508203;9934.801303973736;10341.327813692085;10895.400752958663;10951;11352.148588856035;9955.50222488887;10392.636257730943;10486.632967846088;10575.841362379724;10589.788204236027 11:41:24 INFO - 2016-01-25 11:41:24,355 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:41:24 INFO - 2016-01-25 11:41:24,355 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:41:24 INFO - 2016-01-25 11:41:24,355 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,301 11:41:24 INFO - 2016-01-25 11:41:24,355 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:41:24 INFO - 2016-01-25 11:41:24,356 DEBUG : BROWSER_OUTPUT: __startTimestamp1453750884342__endTimestamp 11:41:24 INFO - 2016-01-25 11:41:24,356 DEBUG : BROWSER_OUTPUT: 11:41:24 INFO - 2016-01-25 11:41:24,356 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:41:24 INFO - 2016-01-25 11:41:24,356 DEBUG : BROWSER_OUTPUT: Number of tests: 6 11:41:24 INFO - 2016-01-25 11:41:24,356 DEBUG : BROWSER_OUTPUT: 11:41:24 INFO - 2016-01-25 11:41:24,356 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5539.98 Median:5762.51 stddev:608.01 (10.6%) stddev-sans-first:582.35 11:41:24 INFO - 2016-01-25 11:41:24,356 DEBUG : BROWSER_OUTPUT: Values: 3234.5 3261.9 3290.3 3298.5 3299.5 5504.7 5505.2 5528.2 5534.3 5535.3 5522.9 5543.9 5573.9 5590.3 5614.7 5050.9 5088.2 5148.9 5166.4 5177.2 4921.1 5064.8 5067.9 5091.1 5203.8 5090.4 5149.1 5149.6 5150.8 5157.4 5094.3 5148.8 5185.6 5204.3 5228.2 4888.2 4917.5 4976.4 5011.5 5084.4 5366.6 5392.4 5402.2 5426.5 5433.9 5933.0 5975.8 5993.9 5996.9 6000.5 5692.5 5859.1 5865.2 5945.6 5971.8 5604.1 5608.6 5642.2 5648.5 5651.0 5946.7 6158.9 6161.9 6164.2 6164.9 5814.6 5814.7 5822.2 5822.9 5826.8 5820.1 5857.5 5865.0 5878.6 5885.5 5850.4 5873.6 5913.4 5921.3 5943.8 5667.3 5762.5 5890.1 5895.3 5933.9 4574.7 4642.1 4644.2 4647.2 4666.0 4119.6 4126.6 4127.0 4137.7 4165.1 5486.1 5584.6 5622.6 5758.8 5766.2 6029.3 6033.9 6039.7 6043.5 6052.7 5706.4 5711.4 5714.1 5730.2 5744.2 5078.4 5137.9 5200.6 5224.1 5308.2 6112.5 6128.1 6129.9 6136.4 6161.2 5926.9 5955.6 6011.7 6030.3 6050.9 6003.8 6070.7 6091.4 6109.5 6200.2 5881.9 5931.9 5969.9 5972.0 6003.1 6040.0 6045.0 6057.2 6060.5 6063.5 5649.2 5694.9 5760.2 5762.7 5928.2 5793.9 5796.6 5814.6 5855.0 5867.2 5771.9 5780.6 5781.7 5804.0 5820.1 5583.1 5677.9 5890.6 5893.4 5923.0 5735.2 5779.0 5806.6 5807.1 5832.6 11:41:24 INFO - 2016-01-25 11:41:24,356 DEBUG : BROWSER_OUTPUT: 11:41:24 INFO - 2016-01-25 11:41:24,356 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:56824.33 Median:38950.32 stddev:116376.05 (298.8%) stddev-sans-first:116625.89 11:41:24 INFO - 2016-01-25 11:41:24,358 DEBUG : BROWSER_OUTPUT: Values: 578.2 632.9 644.9 649.1 660.9 37543.8 37874.8 38095.8 38309.0 38355.6 44664.0 45717.0 45726.0 45793.8 45921.3 8957.0 9027.6 9086.1 9089.2 9103.9 8900.1 8932.1 8973.0 8983.2 9008.2 9097.0 9194.0 9205.9 9206.5 9215.3 8957.7 8999.4 9010.9 9020.6 9060.6 8945.2 9048.0 9049.7 9063.9 9077.5 40937.2 41411.0 41422.4 41470.0 41551.8 3646.3 3656.4 3788.7 3834.2 4272.8 30170.4 30753.8 31057.0 31150.5 31438.5 3607.9 3612.7 3639.3 3663.0 3723.1 298804.0 299462.0 300992.0 301384.0 301421.0 44637.0 45250.5 45415.3 67305.0 67705.0 43678.6 43693.1 43809.6 43826.0 43834.0 15741.4 15761.1 15809.6 15811.2 15823.5 12757.7 12821.9 12828.7 12870.7 12920.3 15054.2 15086.8 15254.5 15312.8 15373.5 6171.6 6182.8 6230.7 6245.7 6269.0 1032.2 1095.4 1122.2 1124.7 1146.7 34420.5 34977.0 35088.6 35151.5 35190.8 1148.9 1155.8 1160.3 1176.8 1210.1 14951.1 15181.8 15242.6 17413.3 17901.7 541738.0 548266.0 548390.0 549810.0 834768.0 59278.7 59492.0 59854.7 59963.7 60138.7 1455.3 1486.0 1494.3 1496.2 1499.4 30874.5 31238.2 31297.7 31480.2 31745.2 49783.0 50052.5 50121.0 50153.5 50501.5 314782.0 315929.0 316345.0 318127.0 318295.0 34382.1 34396.5 34411.5 34434.1 34636.3 55118.4 55522.0 55543.0 55547.0 56083.0 37053.8 38350.2 39005.4 39432.4 39950.4 39578.8 39883.0 39903.2 40231.0 40276.6 38895.2 39098.6 39296.6 39299.8 39399.6 33618.8 34367.1 34567.1 38762.4 39955.2 26370.9 26447.2 26557.0 26676.3 26847.6 11:41:24 INFO - 2016-01-25 11:41:24,358 DEBUG : BROWSER_OUTPUT: 11:41:24 INFO - 2016-01-25 11:41:24,358 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28455.06 Median:1996.91 stddev:81571.03 (4084.9%) stddev-sans-first:81772.63 11:41:24 INFO - 2016-01-25 11:41:24,358 DEBUG : BROWSER_OUTPUT: Values: 383.1 384.8 387.6 389.6 390.3 16152.0 17025.9 17443.3 20336.8 20393.3 11872.3 12064.3 12872.5 16570.5 16582.4 4845.5 4970.2 4975.6 5074.4 5536.1 5390.8 5458.0 5550.2 5558.5 5571.3 5484.3 5485.4 5591.9 6118.2 6173.1 6151.6 6159.1 6167.0 6189.3 6190.4 5453.4 5525.1 5548.6 5552.6 5620.4 13553.1 13947.7 16009.5 21965.8 21985.3 2240.9 2258.9 2296.4 2329.5 2528.9 10349.7 10509.8 10541.8 10668.9 10696.2 1863.9 1886.6 1929.8 1953.8 1999.4 65168.7 65419.7 66484.0 67473.7 67750.3 10786.6 10902.7 10923.7 10965.1 10980.3 14279.6 14329.9 14421.4 14465.6 14621.0 8256.2 8307.3 8309.4 8440.0 8453.1 8143.4 8189.4 8208.9 8222.1 8235.8 4398.6 4576.1 4600.7 4683.1 4815.2 1928.9 1968.7 1981.4 1992.6 1994.4 917.4 1124.2 1128.3 1138.6 1155.4 15295.0 17384.7 17629.8 17631.3 18327.0 971.5 998.7 1014.3 1054.0 1056.8 6404.8 10185.2 10395.5 10649.5 10999.5 414389.0 420696.0 445153.0 445789.0 695667.0 88661.5 91902.0 93527.5 93555.0 94387.0 518.1 521.7 526.0 528.0 532.9 11147.6 11159.9 11370.6 11382.7 11441.0 40073.4 40626.0 40756.4 41427.6 41639.2 52890.0 54003.5 54586.0 56948.7 60465.0 10302.7 10436.2 10448.7 10454.4 10455.9 13877.9 14665.6 17969.8 18878.6 18920.4 15855.3 15947.4 16129.4 16325.8 16572.5 15888.0 15893.3 16034.9 16102.3 16243.2 16225.2 16275.2 16442.3 16483.8 16830.2 10480.3 10635.2 10690.9 10768.3 10768.5 12849.4 16036.0 16096.8 16198.3 16212.8 11:41:24 INFO - 2016-01-25 11:41:24,358 DEBUG : BROWSER_OUTPUT: 11:41:24 INFO - 2016-01-25 11:41:24,358 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5545.75 Median:6537.51 stddev:2851.85 (43.6%) stddev-sans-first:2843.59 11:41:24 INFO - 2016-01-25 11:41:24,359 DEBUG : BROWSER_OUTPUT: Values: 1494.9 1579.6 1625.6 1768.9 1874.0 7754.3 7873.8 8008.3 8076.6 8130.9 7847.3 7926.0 7933.1 7962.1 7984.5 2274.4 2311.6 2315.6 2322.8 2324.2 2224.9 2255.1 2268.4 2270.8 2288.1 2254.2 2274.7 2278.6 2307.4 2322.3 2251.6 2280.0 2328.2 2328.4 2335.7 2307.3 2314.1 2337.8 2338.3 2345.5 7662.4 7747.3 7759.1 7780.0 7794.8 4563.8 4626.9 4656.8 4672.3 4684.0 3009.2 3034.1 3110.4 3113.6 3120.5 998.0 1001.3 1714.9 1757.2 1844.3 10595.5 10670.7 10679.5 10692.1 10716.3 4022.6 4043.8 4044.5 4076.2 4104.5 8792.6 8859.4 8864.6 8887.5 8895.8 4656.4 4662.6 4664.2 4664.7 4673.4 4273.1 4315.5 4342.9 4371.5 4374.8 3440.4 3463.8 3475.7 3495.7 3504.0 1037.8 1048.9 1052.7 1056.4 1159.2 1131.5 1134.8 1138.0 1139.8 1166.3 7207.3 7522.4 7555.7 7566.6 7594.3 1166.7 1181.5 1195.4 1196.6 1197.9 6036.2 6075.4 6116.1 6116.1 6130.4 9042.6 9550.4 9596.6 9617.6 9633.8 9488.0 9535.8 9541.7 9551.8 9643.2 7229.0 7465.1 7487.6 7517.0 7517.5 7081.0 7337.4 7351.2 7367.2 7389.0 8445.0 8559.4 8573.7 8605.1 8627.8 8513.3 8636.4 8647.9 8667.4 8713.4 6885.1 6914.3 6967.6 6974.9 6984.9 7628.9 7701.3 7769.2 7771.3 7772.5 6926.1 7414.2 7446.7 7509.0 7545.4 6929.4 7050.8 7129.6 7148.1 7226.7 7170.7 7203.4 7210.4 7213.8 7250.9 6494.5 6521.7 6553.3 6560.4 6570.0 6601.1 6689.4 6754.2 6806.8 6806.8 11:41:24 INFO - 2016-01-25 11:41:24,359 DEBUG : BROWSER_OUTPUT: 11:41:24 INFO - 2016-01-25 11:41:24,359 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5692.80 Median:6465.05 stddev:1732.80 (26.8%) stddev-sans-first:1690.74 11:41:24 INFO - 2016-01-25 11:41:24,359 DEBUG : BROWSER_OUTPUT: Values: 356.6 362.7 364.3 365.3 366.9 6309.1 6393.5 6403.2 6463.8 6466.3 6284.8 6300.8 6365.4 6396.1 6414.2 4877.0 4940.4 4945.7 4947.6 4960.9 4916.8 4933.9 4940.6 4946.6 4948.4 4659.8 4807.2 4814.6 4820.3 4831.8 4856.6 4856.9 4857.6 4865.5 4879.0 4237.9 4240.7 4244.1 4250.5 4252.6 5969.0 6037.6 6049.6 6053.8 6061.0 5653.6 5657.8 5657.8 5664.8 5665.3 6709.2 6738.4 6738.6 6743.4 6768.3 4681.2 4699.0 4707.7 4708.3 4709.3 6951.8 7019.6 7092.4 7097.9 7102.6 4721.6 4722.5 4723.2 4729.6 4738.0 4801.1 4802.2 4807.0 4807.1 4808.2 5496.7 5583.4 5586.4 5592.6 5595.4 6807.6 6812.3 6813.0 6814.9 6824.7 1650.9 1718.5 1721.1 1722.3 1722.4 1131.7 1136.7 1140.8 1146.7 1149.4 6461.5 6519.3 6552.1 6553.8 6565.9 6985.7 7014.2 7014.2 7016.8 7022.7 6388.8 6478.2 6482.6 6520.6 6548.7 3792.6 3812.4 3830.2 3832.6 3833.7 7197.7 7223.1 7229.6 7238.9 7242.5 7078.3 7173.2 7204.6 7206.7 7305.6 7348.4 7352.0 7366.9 7370.4 7370.7 7129.4 7137.5 7148.9 7154.6 7155.8 6856.3 7000.3 7011.9 7021.2 7044.2 7240.4 7274.6 7308.6 7336.7 7342.7 4737.5 4768.9 4774.9 4777.2 4778.0 6894.6 6970.6 7055.5 7145.5 7149.0 6776.3 6895.4 6927.3 6942.9 6945.7 6877.2 6894.4 6902.9 6912.1 6923.8 6652.2 6708.8 6771.2 6782.1 6783.3 6880.5 6949.8 6965.5 6967.6 6968.6 6670.2 6757.4 6759.9 6762.2 6764.9 11:41:24 INFO - 2016-01-25 11:41:24,359 DEBUG : BROWSER_OUTPUT: 11:41:24 INFO - 2016-01-25 11:41:24,360 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14854.24 Median:4679.25 stddev:17036.53 (364.1%) stddev-sans-first:17051.75 11:41:24 INFO - 2016-01-25 11:41:24,361 DEBUG : BROWSER_OUTPUT: Values: 827.3 854.2 889.0 914.3 916.5 14663.5 14720.8 14774.3 14820.3 14900.4 12752.0 14306.1 14334.8 14373.1 14401.7 903.2 910.4 914.9 915.2 916.2 910.5 913.7 920.9 921.1 923.9 970.2 970.8 973.4 978.1 978.4 968.2 971.6 972.6 973.9 976.3 709.9 715.1 719.4 719.6 720.8 14479.8 14483.5 14570.3 14603.7 14612.9 12914.5 13095.8 13118.3 13718.6 14204.0 10050.5 11572.7 11719.3 11826.6 12111.8 3886.2 3939.3 3966.2 4033.1 4085.3 47416.0 48303.3 48727.3 48811.3 53935.0 10790.5 10938.6 10953.7 11061.8 11253.3 19208.9 19291.4 19301.6 19307.1 19384.3 7796.6 8166.6 8255.5 8300.5 8461.9 4669.9 4688.6 4752.9 4799.4 4811.9 3238.8 3299.7 3389.3 3470.3 3477.0 596.2 613.6 616.4 620.4 628.6 720.2 721.4 734.2 758.9 760.4 9075.1 9252.6 9345.1 9394.9 9536.5 701.5 709.4 724.7 733.5 738.5 4395.9 4397.0 4403.3 4487.6 4582.1 58551.7 61423.7 61710.0 61887.0 62138.4 47981.3 48923.0 53327.0 54536.0 54785.5 52780.5 53375.0 54384.0 55008.0 55865.4 8982.3 9069.7 9507.8 9824.4 9836.3 37069.8 38195.2 38296.6 38769.6 39377.8 44164.6 46157.3 49419.5 49833.8 49862.0 11250.0 11531.6 11721.9 12260.3 12356.1 12016.5 12438.1 12590.0 12693.7 13281.4 11824.4 12434.5 12531.6 12606.2 13172.1 11568.5 11571.2 11692.8 11835.6 12274.3 12151.1 12294.1 12374.8 12650.2 12704.7 9934.8 10341.3 10895.4 10951.0 11352.1 9955.5 10392.6 10486.6 10575.8 10589.8 11:41:24 INFO - 2016-01-25 11:41:24,361 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:41:24 INFO - 2016-01-25 11:41:24,361 DEBUG : BROWSER_OUTPUT: 11:41:25 INFO - 2016-01-25 11:41:25,001 INFO : Browser exited with error code: 0 11:41:25 INFO - 2016-01-25 11:41:25,020 INFO : Completed test dromaeo_css (00:18:28) 11:41:25 INFO - 2016-01-25 11:41:25,020 INFO : Starting test kraken 11:41:25 INFO - 2016-01-25 11:41:25,020 DEBUG : operating with platform_type : linux_ 11:41:25 INFO - 2016-01-25 11:41:25,020 INFO : Initialising browser for kraken test... 11:41:25 INFO - 2016-01-25 11:41:25,027 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpARgtis/profile http://localhost:34845/getInfo.html 11:41:28 INFO - 2016-01-25 11:41:28,399 DEBUG : BROWSER_OUTPUT: 11:41:28 INFO - 2016-01-25 11:41:28,400 DEBUG : BROWSER_OUTPUT: (process:27031): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:41:29 INFO - 2016-01-25 11:41:29,166 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:41:29 INFO - 2016-01-25 11:41:29,166 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:41:29 INFO - 2016-01-25 11:41:29,166 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:41:29 INFO - 2016-01-25 11:41:29,166 DEBUG : BROWSER_OUTPUT: __metrics 11:41:30 INFO - 2016-01-25 11:41:30,069 INFO : Browser initialized. 11:41:30 INFO - 2016-01-25 11:41:30,070 INFO : Running cycle 1/1 for kraken test... 11:41:30 INFO - 2016-01-25 11:41:30,070 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpARgtis/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:41:31 INFO - 2016-01-25 11:41:31,352 DEBUG : BROWSER_OUTPUT: 11:41:31 INFO - 2016-01-25 11:41:31,354 DEBUG : BROWSER_OUTPUT: (process:27145): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:41:41 INFO - 2016-01-25 11:41:41,859 DEBUG : BROWSER_OUTPUT: RSS: Main: 135725056 11:41:41 INFO - 2016-01-25 11:41:41,859 DEBUG : BROWSER_OUTPUT: 11:41:44 INFO - 2016-01-25 11:41:44,355 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34845/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34845/tests/kraken/driver.html?testName=audio-beat-detection) 11:41:44 INFO - 2016-01-25 11:41:44,957 DEBUG : BROWSER_OUTPUT: RSS: Main: 138850304 11:41:44 INFO - 2016-01-25 11:41:44,957 DEBUG : BROWSER_OUTPUT: 11:41:47 INFO - 2016-01-25 11:41:47,538 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34845/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34845/tests/kraken/driver.html?testName=audio-dft) 11:41:48 INFO - 2016-01-25 11:41:48,140 DEBUG : BROWSER_OUTPUT: RSS: Main: 138956800 11:41:48 INFO - 2016-01-25 11:41:48,141 DEBUG : BROWSER_OUTPUT: 11:41:50 INFO - 2016-01-25 11:41:50,980 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34845/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34845/tests/kraken/driver.html?testName=audio-fft) 11:41:51 INFO - 2016-01-25 11:41:51,547 DEBUG : BROWSER_OUTPUT: RSS: Main: 138993664 11:41:51 INFO - 2016-01-25 11:41:51,547 DEBUG : BROWSER_OUTPUT: 11:41:53 INFO - 2016-01-25 11:41:53,568 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34845/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34845/tests/kraken/driver.html?testName=audio-oscillator) 11:41:54 INFO - 2016-01-25 11:41:54,157 DEBUG : BROWSER_OUTPUT: RSS: Main: 138874880 11:41:54 INFO - 2016-01-25 11:41:54,158 DEBUG : BROWSER_OUTPUT: 11:41:56 INFO - 2016-01-25 11:41:56,344 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34845/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34845/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:41:56 INFO - 2016-01-25 11:41:56,926 DEBUG : BROWSER_OUTPUT: RSS: Main: 138104832 11:41:56 INFO - 2016-01-25 11:41:56,926 DEBUG : BROWSER_OUTPUT: 11:41:59 INFO - 2016-01-25 11:41:59,836 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34845/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34845/tests/kraken/driver.html?testName=imaging-darkroom) 11:42:00 INFO - 2016-01-25 11:42:00,422 DEBUG : BROWSER_OUTPUT: RSS: Main: 137572352 11:42:00 INFO - 2016-01-25 11:42:00,422 DEBUG : BROWSER_OUTPUT: 11:42:03 INFO - 2016-01-25 11:42:03,749 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34845/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34845/tests/kraken/driver.html?testName=imaging-desaturate) 11:42:04 INFO - 2016-01-25 11:42:04,339 DEBUG : BROWSER_OUTPUT: RSS: Main: 138002432 11:42:04 INFO - 2016-01-25 11:42:04,339 DEBUG : BROWSER_OUTPUT: 11:42:07 INFO - 2016-01-25 11:42:07,158 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34845/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34845/tests/kraken/driver.html?testName=json-parse-financial) 11:42:07 INFO - 2016-01-25 11:42:07,741 DEBUG : BROWSER_OUTPUT: RSS: Main: 138051584 11:42:07 INFO - 2016-01-25 11:42:07,741 DEBUG : BROWSER_OUTPUT: 11:42:09 INFO - 2016-01-25 11:42:09,295 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34845/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34845/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:42:09 INFO - 2016-01-25 11:42:09,869 DEBUG : BROWSER_OUTPUT: RSS: Main: 138969088 11:42:09 INFO - 2016-01-25 11:42:09,869 DEBUG : BROWSER_OUTPUT: 11:42:11 INFO - 2016-01-25 11:42:11,626 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34845/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34845/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:42:12 INFO - 2016-01-25 11:42:12,232 DEBUG : BROWSER_OUTPUT: RSS: Main: 138682368 11:42:12 INFO - 2016-01-25 11:42:12,233 DEBUG : BROWSER_OUTPUT: 11:42:14 INFO - 2016-01-25 11:42:14,246 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34845/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34845/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:42:14 INFO - 2016-01-25 11:42:14,828 DEBUG : BROWSER_OUTPUT: RSS: Main: 138629120 11:42:14 INFO - 2016-01-25 11:42:14,828 DEBUG : BROWSER_OUTPUT: 11:42:17 INFO - 2016-01-25 11:42:17,264 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34845/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34845/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:42:17 INFO - 2016-01-25 11:42:17,856 DEBUG : BROWSER_OUTPUT: RSS: Main: 138805248 11:42:17 INFO - 2016-01-25 11:42:17,857 DEBUG : BROWSER_OUTPUT: 11:42:20 INFO - 2016-01-25 11:42:20,374 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34845/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34845/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:42:20 INFO - 2016-01-25 11:42:20,956 DEBUG : BROWSER_OUTPUT: RSS: Main: 138280960 11:42:20 INFO - 2016-01-25 11:42:20,956 DEBUG : BROWSER_OUTPUT: 11:42:22 INFO - 2016-01-25 11:42:22,611 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34845/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34845/tests/kraken/driver.html?testName=ai-astar) 11:42:22 INFO - 2016-01-25 11:42:22,863 DEBUG : BROWSER_OUTPUT: RSS: Main: 137990144 11:42:22 INFO - 2016-01-25 11:42:22,863 DEBUG : BROWSER_OUTPUT: 11:42:22 INFO - 2016-01-25 11:42:22,864 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:42:22 INFO - 2016-01-25 11:42:22,865 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:42:22 INFO - 2016-01-25 11:42:22,866 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:42:22 INFO - 2016-01-25 11:42:22,866 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:42:22 INFO - 2016-01-25 11:42:22,866 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;108;112;110;113;122;112;112;111;113 11:42:22 INFO - 2016-01-25 11:42:22,866 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;146;122;146;161;123;158;157;124;158;122 11:42:22 INFO - 2016-01-25 11:42:22,867 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;164;162;163;163;164;162;161;168;162 11:42:22 INFO - 2016-01-25 11:42:22,867 DEBUG : BROWSER_OUTPUT: |3;audio-fft;78;72;75;156;72;71;71;73;159;72 11:42:22 INFO - 2016-01-25 11:42:22,867 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;92;137;101;94;93;138;92;92;130 11:42:22 INFO - 2016-01-25 11:42:22,867 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;110;110;110;110;109;109;110;110;110 11:42:22 INFO - 2016-01-25 11:42:22,867 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;149;147;147;148;150;148;148;147;150;148 11:42:22 INFO - 2016-01-25 11:42:22,867 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;99;96;97;98;97;96;96;99 11:42:22 INFO - 2016-01-25 11:42:22,867 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;63;61;58;59;59;62;58;56;57 11:42:22 INFO - 2016-01-25 11:42:22,868 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;62;74;63;64;64;64;64;63;63;64 11:42:22 INFO - 2016-01-25 11:42:22,868 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;80;81;88;89;81;89;81;80;82;82 11:42:22 INFO - 2016-01-25 11:42:22,868 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;114;122;114;120;114;120;111;121;115;127 11:42:22 INFO - 2016-01-25 11:42:22,868 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;140;146;148;148;140;148;141;146;149;140 11:42:22 INFO - 2016-01-25 11:42:22,868 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;64;66;66;69;68;66;70;67;71;65 11:42:22 INFO - 2016-01-25 11:42:22,868 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:42:22 INFO - 2016-01-25 11:42:22,868 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:42:22 INFO - 2016-01-25 11:42:22,868 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,688 11:42:22 INFO - 2016-01-25 11:42:22,869 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:42:22 INFO - 2016-01-25 11:42:22,869 DEBUG : BROWSER_OUTPUT: __startTimestamp1453750942864__endTimestamp 11:42:22 INFO - 2016-01-25 11:42:22,869 DEBUG : BROWSER_OUTPUT: 11:42:22 INFO - 2016-01-25 11:42:22,872 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:42:22 INFO - 2016-01-25 11:42:22,873 DEBUG : BROWSER_OUTPUT: Number of tests: 14 11:42:22 INFO - 2016-01-25 11:42:22,873 DEBUG : BROWSER_OUTPUT: 11:42:22 INFO - 2016-01-25 11:42:22,873 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.40 Median:112.00 stddev:3.69 (3.3%) stddev-sans-first:3.88 11:42:22 INFO - 2016-01-25 11:42:22,873 DEBUG : BROWSER_OUTPUT: Values: 111.0 108.0 112.0 110.0 113.0 122.0 112.0 112.0 111.0 113.0 11:42:22 INFO - 2016-01-25 11:42:22,874 DEBUG : BROWSER_OUTPUT: 11:42:22 INFO - 2016-01-25 11:42:22,874 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.70 Median:151.50 stddev:17.04 (11.2%) stddev-sans-first:18.01 11:42:22 INFO - 2016-01-25 11:42:22,874 DEBUG : BROWSER_OUTPUT: Values: 146.0 122.0 146.0 161.0 123.0 158.0 157.0 124.0 158.0 122.0 11:42:22 INFO - 2016-01-25 11:42:22,874 DEBUG : BROWSER_OUTPUT: 11:42:22 INFO - 2016-01-25 11:42:22,874 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.10 Median:163.00 stddev:1.97 (1.2%) stddev-sans-first:2.05 11:42:22 INFO - 2016-01-25 11:42:22,875 DEBUG : BROWSER_OUTPUT: Values: 162.0 164.0 162.0 163.0 163.0 164.0 162.0 161.0 168.0 162.0 11:42:22 INFO - 2016-01-25 11:42:22,875 DEBUG : BROWSER_OUTPUT: 11:42:22 INFO - 2016-01-25 11:42:22,875 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:89.90 Median:72.00 stddev:35.70 (49.6%) stddev-sans-first:37.60 11:42:22 INFO - 2016-01-25 11:42:22,875 DEBUG : BROWSER_OUTPUT: Values: 78.0 72.0 75.0 156.0 72.0 71.0 71.0 73.0 159.0 72.0 11:42:22 INFO - 2016-01-25 11:42:22,876 DEBUG : BROWSER_OUTPUT: 11:42:22 INFO - 2016-01-25 11:42:22,876 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.10 Median:92.00 stddev:20.23 (22.0%) stddev-sans-first:20.80 11:42:22 INFO - 2016-01-25 11:42:22,876 DEBUG : BROWSER_OUTPUT: Values: 92.0 92.0 137.0 101.0 94.0 93.0 138.0 92.0 92.0 130.0 11:42:22 INFO - 2016-01-25 11:42:22,876 DEBUG : BROWSER_OUTPUT: 11:42:22 INFO - 2016-01-25 11:42:22,876 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.44 11:42:22 INFO - 2016-01-25 11:42:22,877 DEBUG : BROWSER_OUTPUT: Values: 111.0 110.0 110.0 110.0 110.0 109.0 109.0 110.0 110.0 110.0 11:42:22 INFO - 2016-01-25 11:42:22,877 DEBUG : BROWSER_OUTPUT: 11:42:22 INFO - 2016-01-25 11:42:22,877 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:1.14 (0.8%) stddev-sans-first:1.17 11:42:22 INFO - 2016-01-25 11:42:22,877 DEBUG : BROWSER_OUTPUT: Values: 149.0 147.0 147.0 148.0 150.0 148.0 148.0 147.0 150.0 148.0 11:42:22 INFO - 2016-01-25 11:42:22,878 DEBUG : BROWSER_OUTPUT: 11:42:22 INFO - 2016-01-25 11:42:22,878 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:97.00 Median:97.00 stddev:1.25 (1.3%) stddev-sans-first:1.27 11:42:22 INFO - 2016-01-25 11:42:22,878 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 99.0 96.0 97.0 98.0 97.0 96.0 96.0 99.0 11:42:22 INFO - 2016-01-25 11:42:22,878 DEBUG : BROWSER_OUTPUT: 11:42:22 INFO - 2016-01-25 11:42:22,878 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.20 Median:59.00 stddev:2.20 (3.7%) stddev-sans-first:2.33 11:42:22 INFO - 2016-01-25 11:42:22,878 DEBUG : BROWSER_OUTPUT: Values: 59.0 63.0 61.0 58.0 59.0 59.0 62.0 58.0 56.0 57.0 11:42:22 INFO - 2016-01-25 11:42:22,878 DEBUG : BROWSER_OUTPUT: 11:42:22 INFO - 2016-01-25 11:42:22,878 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:64.00 stddev:3.41 (5.3%) stddev-sans-first:3.49 11:42:22 INFO - 2016-01-25 11:42:22,879 DEBUG : BROWSER_OUTPUT: Values: 62.0 74.0 63.0 64.0 64.0 64.0 64.0 63.0 63.0 64.0 11:42:22 INFO - 2016-01-25 11:42:22,879 DEBUG : BROWSER_OUTPUT: 11:42:22 INFO - 2016-01-25 11:42:22,879 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:82.00 stddev:3.77 (4.6%) stddev-sans-first:3.81 11:42:22 INFO - 2016-01-25 11:42:22,879 DEBUG : BROWSER_OUTPUT: Values: 80.0 81.0 88.0 89.0 81.0 89.0 81.0 80.0 82.0 82.0 11:42:22 INFO - 2016-01-25 11:42:22,879 DEBUG : BROWSER_OUTPUT: 11:42:22 INFO - 2016-01-25 11:42:22,880 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:117.80 Median:120.00 stddev:4.94 (4.1%) stddev-sans-first:5.04 11:42:22 INFO - 2016-01-25 11:42:22,880 DEBUG : BROWSER_OUTPUT: Values: 114.0 122.0 114.0 120.0 114.0 120.0 111.0 121.0 115.0 127.0 11:42:22 INFO - 2016-01-25 11:42:22,880 DEBUG : BROWSER_OUTPUT: 11:42:22 INFO - 2016-01-25 11:42:22,880 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.60 Median:147.00 stddev:3.86 (2.6%) stddev-sans-first:3.72 11:42:22 INFO - 2016-01-25 11:42:22,880 DEBUG : BROWSER_OUTPUT: Values: 140.0 146.0 148.0 148.0 140.0 148.0 141.0 146.0 149.0 140.0 11:42:22 INFO - 2016-01-25 11:42:22,881 DEBUG : BROWSER_OUTPUT: 11:42:22 INFO - 2016-01-25 11:42:22,881 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.50 stddev:2.25 (3.3%) stddev-sans-first:2.07 11:42:22 INFO - 2016-01-25 11:42:22,881 DEBUG : BROWSER_OUTPUT: Values: 64.0 66.0 66.0 69.0 68.0 66.0 70.0 67.0 71.0 65.0 11:42:22 INFO - 2016-01-25 11:42:22,881 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:42:22 INFO - 2016-01-25 11:42:22,881 DEBUG : BROWSER_OUTPUT: 11:42:23 INFO - 2016-01-25 11:42:23,705 INFO : Browser exited with error code: 0 11:42:23 INFO - 2016-01-25 11:42:23,758 INFO : Completed test kraken (00:00:58) 11:42:23 INFO - 2016-01-25 11:42:23,759 INFO : Starting test v8_7 11:42:23 INFO - 2016-01-25 11:42:23,759 DEBUG : operating with platform_type : linux_ 11:42:23 INFO - 2016-01-25 11:42:23,759 INFO : Initialising browser for v8_7 test... 11:42:23 INFO - 2016-01-25 11:42:23,765 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAOEpZR/profile http://localhost:34845/getInfo.html 11:42:27 INFO - 2016-01-25 11:42:27,164 DEBUG : BROWSER_OUTPUT: 11:42:27 INFO - 2016-01-25 11:42:27,165 DEBUG : BROWSER_OUTPUT: (process:27453): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:42:27 INFO - 2016-01-25 11:42:27,995 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:42:27 INFO - 2016-01-25 11:42:27,996 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:42:27 INFO - 2016-01-25 11:42:27,996 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:42:27 INFO - 2016-01-25 11:42:27,996 DEBUG : BROWSER_OUTPUT: __metrics 11:42:28 INFO - 2016-01-25 11:42:28,949 INFO : Browser initialized. 11:42:28 INFO - 2016-01-25 11:42:28,950 INFO : Running cycle 1/1 for v8_7 test... 11:42:28 INFO - 2016-01-25 11:42:28,950 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAOEpZR/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:42:30 INFO - 2016-01-25 11:42:30,254 DEBUG : BROWSER_OUTPUT: 11:42:30 INFO - 2016-01-25 11:42:30,254 DEBUG : BROWSER_OUTPUT: (process:27567): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:42:40 INFO - 2016-01-25 11:42:40,762 DEBUG : BROWSER_OUTPUT: RSS: Main: 135950336 11:42:40 INFO - 2016-01-25 11:42:40,762 DEBUG : BROWSER_OUTPUT: 11:43:02 INFO - 2016-01-25 11:43:02,100 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34845/tests/v8_7/run.html (next: http://localhost:34845/tests/v8_7/run.html) 11:43:02 INFO - 2016-01-25 11:43:02,350 DEBUG : BROWSER_OUTPUT: RSS: Main: 136073216 11:43:02 INFO - 2016-01-25 11:43:02,351 DEBUG : BROWSER_OUTPUT: 11:43:02 INFO - 2016-01-25 11:43:02,351 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:43:02 INFO - 2016-01-25 11:43:02,351 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:43:02 INFO - 2016-01-25 11:43:02,351 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:43:02 INFO - 2016-01-25 11:43:02,351 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:43:02 INFO - 2016-01-25 11:43:02,351 DEBUG : BROWSER_OUTPUT: |0;Richards;165.26194017517767 11:43:02 INFO - 2016-01-25 11:43:02,351 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;173.16017316017317 11:43:02 INFO - 2016-01-25 11:43:02,351 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.55153203342616 11:43:02 INFO - 2016-01-25 11:43:02,352 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5143.589743589743 11:43:02 INFO - 2016-01-25 11:43:02,352 DEBUG : BROWSER_OUTPUT: |4;RayTrace;930.2325581395348 11:43:02 INFO - 2016-01-25 11:43:02,352 DEBUG : BROWSER_OUTPUT: |5;Earley;542.5935973955508 11:43:02 INFO - 2016-01-25 11:43:02,353 DEBUG : BROWSER_OUTPUT: |6;Boyer;11010.989010989011 11:43:02 INFO - 2016-01-25 11:43:02,353 DEBUG : BROWSER_OUTPUT: |7;RegExp;24047.619047619046 11:43:02 INFO - 2016-01-25 11:43:02,353 DEBUG : BROWSER_OUTPUT: |8;Splay;514.668039114771 11:43:02 INFO - 2016-01-25 11:43:02,353 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 11:43:02 INFO - 2016-01-25 11:43:02,353 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:43:02 INFO - 2016-01-25 11:43:02,354 DEBUG : BROWSER_OUTPUT: __startTimestamp1453750982349__endTimestamp 11:43:02 INFO - 2016-01-25 11:43:02,354 DEBUG : BROWSER_OUTPUT: 11:43:02 INFO - 2016-01-25 11:43:02,354 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:43:02 INFO - 2016-01-25 11:43:02,354 DEBUG : BROWSER_OUTPUT: Number of tests: 10 11:43:02 INFO - 2016-01-25 11:43:02,354 DEBUG : BROWSER_OUTPUT: 11:43:02 INFO - 2016-01-25 11:43:02,354 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.26 Median:165.26 stddev:0.00 (0.0%) 11:43:02 INFO - 2016-01-25 11:43:02,355 DEBUG : BROWSER_OUTPUT: Values: 165.3 11:43:02 INFO - 2016-01-25 11:43:02,355 DEBUG : BROWSER_OUTPUT: 11:43:02 INFO - 2016-01-25 11:43:02,355 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:173.16 Median:173.16 stddev:0.00 (0.0%) 11:43:02 INFO - 2016-01-25 11:43:02,355 DEBUG : BROWSER_OUTPUT: Values: 173.2 11:43:02 INFO - 2016-01-25 11:43:02,356 DEBUG : BROWSER_OUTPUT: 11:43:02 INFO - 2016-01-25 11:43:02,356 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.55 Median:278.55 stddev:0.00 (0.0%) 11:43:02 INFO - 2016-01-25 11:43:02,356 DEBUG : BROWSER_OUTPUT: Values: 278.6 11:43:02 INFO - 2016-01-25 11:43:02,356 DEBUG : BROWSER_OUTPUT: 11:43:02 INFO - 2016-01-25 11:43:02,356 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5143.59 Median:5143.59 stddev:0.00 (0.0%) 11:43:02 INFO - 2016-01-25 11:43:02,356 DEBUG : BROWSER_OUTPUT: Values: 5143.6 11:43:02 INFO - 2016-01-25 11:43:02,356 DEBUG : BROWSER_OUTPUT: 11:43:02 INFO - 2016-01-25 11:43:02,357 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:930.23 Median:930.23 stddev:0.00 (0.0%) 11:43:02 INFO - 2016-01-25 11:43:02,357 DEBUG : BROWSER_OUTPUT: Values: 930.2 11:43:02 INFO - 2016-01-25 11:43:02,357 DEBUG : BROWSER_OUTPUT: 11:43:02 INFO - 2016-01-25 11:43:02,357 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:542.59 Median:542.59 stddev:0.00 (0.0%) 11:43:02 INFO - 2016-01-25 11:43:02,357 DEBUG : BROWSER_OUTPUT: Values: 542.6 11:43:02 INFO - 2016-01-25 11:43:02,358 DEBUG : BROWSER_OUTPUT: 11:43:02 INFO - 2016-01-25 11:43:02,358 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11010.99 Median:11010.99 stddev:0.00 (0.0%) 11:43:02 INFO - 2016-01-25 11:43:02,358 DEBUG : BROWSER_OUTPUT: Values: 11011.0 11:43:02 INFO - 2016-01-25 11:43:02,358 DEBUG : BROWSER_OUTPUT: 11:43:02 INFO - 2016-01-25 11:43:02,358 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24047.62 Median:24047.62 stddev:0.00 (0.0%) 11:43:02 INFO - 2016-01-25 11:43:02,359 DEBUG : BROWSER_OUTPUT: Values: 24047.6 11:43:02 INFO - 2016-01-25 11:43:02,359 DEBUG : BROWSER_OUTPUT: 11:43:02 INFO - 2016-01-25 11:43:02,359 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:514.67 Median:514.67 stddev:0.00 (0.0%) 11:43:02 INFO - 2016-01-25 11:43:02,359 DEBUG : BROWSER_OUTPUT: Values: 514.7 11:43:02 INFO - 2016-01-25 11:43:02,359 DEBUG : BROWSER_OUTPUT: 11:43:02 INFO - 2016-01-25 11:43:02,359 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 11:43:02 INFO - 2016-01-25 11:43:02,359 DEBUG : BROWSER_OUTPUT: Values: 4835.7 11:43:02 INFO - 2016-01-25 11:43:02,359 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:43:02 INFO - 2016-01-25 11:43:02,359 DEBUG : BROWSER_OUTPUT: 11:43:03 INFO - 2016-01-25 11:43:03,137 INFO : Browser exited with error code: 0 11:43:03 INFO - 2016-01-25 11:43:03,152 INFO : Completed test v8_7 (00:00:39) 11:43:03 INFO - 2016-01-25 11:43:03,422 INFO : Completed test suite (00:20:06) 11:43:03 INFO - 2016-01-25 11:43:03,422 DEBUG : Working with test: dromaeo_css 11:43:03 INFO - 2016-01-25 11:43:03,422 DEBUG : Generating results file: dromaeo_css 11:43:03 INFO - 2016-01-25 11:43:03,423 DEBUG : Working with test: kraken 11:43:03 INFO - 2016-01-25 11:43:03,423 DEBUG : Generating results file: kraken 11:43:03 INFO - 2016-01-25 11:43:03,424 INFO : javascript benchmark 11:43:03 INFO - 2016-01-25 11:43:03,424 DEBUG : Working with test: v8_7 11:43:03 INFO - 2016-01-25 11:43:03,424 DEBUG : Generating results file: v8_7 11:43:03 INFO - 2016-01-25 11:43:03,424 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:43:03 INFO - 2016-01-25 11:43:03,497 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 11:43:03 INFO - 2016-01-25 11:43:03,498 DEBUG : process_Request line: dromaeo_css 7371.69 graph.html#tests=[[72,52,43]] 11:43:03 INFO - 2016-01-25 11:43:03,498 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:43:03 INFO - 2016-01-25 11:43:03,540 DEBUG : process_Request line: kraken 1504.90 graph.html#tests=[[232,52,43]] 11:43:03 INFO - 2016-01-25 11:43:03,540 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:43:03 INFO - 2016-01-25 11:43:03,576 DEBUG : process_Request line: v8_7 23223.65 graph.html#tests=[[230,52,43]] 11:43:03 INFO - 2016-01-25 11:43:03,577 INFO : javascript benchmark 11:43:03 INFO - 2016-01-25 11:43:03,581 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3234.45014347561, 3261.853216605254, 3290.2761392493644, 3298.5052242163674, 3299.4555898276785, 5504.669719816814, 5505.174223866412, 5528.198411230369, 5534.280543529336, 5535.308086489189, 5522.944770552293, 5543.861403464905, 5573.916391254134, 5590.273264475612, 5614.691191984439, 5050.924236136461, 5088.18589025756, 5148.948510514884, 5166.354205724285, 5177.223416487519, 4921.064997650435, 5064.848054558351, 5067.93573349597, 5091.109055915219, 5203.817866374678, 5090.363704536933, 5149.124648809692, 5149.613778966574, 5150.819721309755, 5157.3811142662935, 5094.286799848006, 5148.819791307286, 5185.585153187736, 5204.323437953042, 5228.241904923784, 4888.242322440027, 4917.459079501252, 4976.377952755905, 5011.498850114996, 5084.389873215201, 5366.597505187087, 5392.379876314235, 5402.189671549299, 5426.484483974016, 5433.864153396157, 5932.991391463462, 5975.790847320366, 5993.9400605993815, 5996.880062398771, 6000.459958603703, 5692.5161361284345, 5859.091840764689, 5865.237519122486, 5945.643261404286, 5971.790987315467, 5604.131359639263, 5608.6073974821775, 5642.210090587321, 5648.54811615074, 5650.971745141248, 5946.67293298864, 6158.876822463526, 6161.907571386433, 6164.229471316085, 6164.907526387108, 5814.622049566765, 5814.651120932757, 5822.155787410802, 5822.941770582324, 5826.82519524415, 5820.068788993825, 5857.531397488191, 5864.970675146682, 5878.617889837147, 5885.529157667376, 5850.385709500526, 5873.559483038789, 5913.408659134052, 5921.319048309413, 5943.821685349447, 5667.319921609434, 5762.510186634183, 5890.057590785539, 5895.322037965603, 5933.851653708692, 4574.748388838646, 4642.094791515689, 4644.187267228222, 4647.209974304376, 4665.976670116627, 4119.629233369011, 4126.566710495415, 4126.958730412717, 4137.731047481904, 4165.062860856283, 5486.067368547357, 5584.636998595079, 5622.57830662702, 5758.798442054592, 5766.192733017381, 6029.306629737636, 6033.879322413527, 6039.66781826995, 6043.546733994968, 6052.727627256696, 5706.429357064343, 5711.400302968212, 5714.085746280575, 5730.19777231188, 5744.224529688522, 5078.415982162099, 5137.871553211125, 5200.583953283728, 5224.111900976843, 5308.150695888639, 6112.51099912006, 6128.080787881764, 6129.938700613026, 6136.417040381157, 6161.168242287324, 5926.911096333644, 5955.642661440327, 6011.6693581853415, 6030.336662967158, 6050.878982420239, 6003.759849605967, 6070.666113363807, 6091.42131497507, 6109.450149486567, 6200.162977998093, 5881.852953676193, 5931.851703707442, 5969.8806023878415, 5971.970140149271, 6003.099535069775, 6039.969800150971, 6045.0, 6057.242844644419, 6060.454559089703, 6063.484603808725, 5649.180868773922, 5694.943050569441, 5760.193572899713, 5762.711864406847, 5928.199693041384, 5793.94206057934, 5796.594238403271, 5814.592978491465, 5855.0, 5867.178594996619, 5771.932192544393, 5780.5953583248765, 5781.739821708117, 5804.042333015174, 5820.097884827858, 5583.050881350099, 5677.858053548694, 5890.646561206341, 5893.381194974638, 5922.993091174424, 5735.197072409783, 5779.046457334661, 5806.5645076618575, 5807.0998995155815, 5832.591718579659], "unit": "ms", "name": "dojo.html", "value": 5500.523017292402}, {"lowerIsBetter": false, "replicates": [578.1558923971002, 632.8892443822332, 644.8516841126541, 649.1236830279126, 660.9074729537863, 37543.81228093859, 37874.8106259469, 38095.809520952425, 38308.99999999996, 38355.616443835555, 44664.0, 45717.0, 45726.0, 45793.771031144795, 45921.31118033232, 8957.0, 9027.638894444215, 9086.091390860927, 9089.181973622373, 9103.908960910405, 8900.065493123226, 8932.062133475956, 8973.0, 8983.19151276385, 9008.234300084468, 9097.0, 9193.95403022984, 9205.907940920571, 9206.539673016356, 9215.308851836138, 8957.731268062002, 8999.415038022507, 9010.909890901139, 9020.639174433014, 9060.592273347682, 8945.239654629364, 9048.049954754788, 9049.728508144766, 9063.909360906438, 9077.455352678795, 40937.18125637471, 41411.0, 41422.37866432006, 41470.0, 41551.7922410389, 3646.307201631708, 3656.4332528457867, 3788.677962373202, 3834.2331533693373, 4272.764997925113, 30170.396592068035, 30753.846230768926, 31057.0, 31150.532742008887, 31438.528422073687, 3607.9278414431565, 3612.6929211017095, 3639.290338384016, 3663.0, 3723.0506220913494, 298804.0, 299462.0, 300992.0, 301383.9999999978, 301421.0, 44637.0, 45250.54749452463, 45415.31877021847, 67305.0, 67705.0, 43678.563214368085, 43693.12613747707, 43809.56190438118, 43826.0, 43834.0, 15741.44904928322, 15761.054336739602, 15809.604759880865, 15811.209439528207, 15823.525294241192, 12757.744845103047, 12821.935890320488, 12828.743425131444, 12870.67823304425, 12920.289384083777, 15054.247287635575, 15086.849131508545, 15254.542363729106, 15312.846871531143, 15373.461928832437, 6171.59884607499, 6182.752689892444, 6230.6884655767935, 6245.657183705525, 6269.025257044016, 1032.2413026425572, 1095.4139535348709, 1122.2088427658482, 1124.707576030238, 1146.6846617180342, 34420.48369274463, 34977.0, 35088.64911350905, 35151.4727279091, 35190.824045879606, 1148.8563929508812, 1155.8035134027236, 1160.3270103340042, 1176.7764124816258, 1210.062201793617, 14951.102933824006, 15181.772273415907, 15242.618934526503, 17413.3034678614, 17901.7314740279, 541738.0, 548266.0, 548390.0, 549810.0, 834768.0, 59278.70360648169, 59492.0, 59854.70072649609, 59963.70018149881, 60138.699306503186, 1455.3087283540444, 1485.9925700371646, 1494.275276490901, 1496.2219645784132, 1499.3552772307794, 30874.53688194724, 31238.15007097596, 31297.687023129478, 31480.212994675316, 31745.20636984094, 49783.0, 50052.499475004784, 50121.0, 50153.498465016346, 50501.49498505115, 314782.0, 315929.0, 316345.0, 318127.0, 318295.0, 34382.14044648804, 34396.48405273973, 34411.4838277421, 34434.139146521535, 34636.30727385489, 55118.44881551294, 55522.0, 55543.0, 55547.0, 56083.0, 37053.81473092617, 38350.23299533938, 39005.414918776805, 39432.40851387289, 39950.40074398944, 39578.802105990435, 39883.0, 39903.2019359617, 40231.0, 40276.597234027286, 38895.222095557365, 39098.609013909496, 39296.60703392929, 39299.80350098346, 39399.60600394074, 33618.831905840314, 34367.14082147966, 34567.135821604665, 38762.418563721, 39955.200895982496, 26370.868145659148, 26447.206583802516, 26557.0, 26676.333091672863, 26847.597286041117], "unit": "ms", "name": "ext.html", "value": 19638.152505261663}, {"lowerIsBetter": false, "replicates": [383.08824996508304, 384.7576027102925, 387.56399051067547, 389.60260534255076, 390.2682470368059, 16152.0, 17025.91487042563, 17443.302267909283, 20336.796632033656, 20393.286234981777, 11872.347020913847, 12064.336461494615, 12872.485100595964, 16570.502884913443, 16582.419615313465, 4845.515448455153, 4970.204767237243, 4975.626827987898, 5074.416442109149, 5536.114221724505, 5390.757415916273, 5457.972710136443, 5550.16747487878, 5558.527525160366, 5571.331440227158, 5484.287042684446, 5485.369182544018, 5591.944080559203, 6118.235220597426, 6173.135760993465, 6151.569390142692, 6159.106929495243, 6167.0, 6189.319174890758, 6190.442860142563, 5453.3728621208675, 5525.11598144299, 5548.611597188198, 5552.583556233299, 5620.437956204388, 13553.119047261896, 13947.721045579134, 16009.519714408587, 21965.780342196533, 21985.340439786833, 2240.943976400603, 2258.9322320330416, 2296.391456264091, 2329.4758679297192, 2528.8609126498036, 10349.74125646865, 10509.84235236472, 10541.789164216672, 10668.94665526675, 10696.197785166143, 1863.897485638303, 1886.6321067391864, 1929.8359639430525, 1953.794851540582, 1999.3701983875033, 65168.67415662891, 65419.67290163566, 66484.0, 67473.66263168702, 67750.32249677539, 10786.568537258421, 10902.672919812418, 10923.726906827234, 10965.067969222706, 10980.341179529094, 14279.64300892486, 14329.85670143306, 14421.35103920326, 14465.638359041108, 14621.0, 8256.174382561816, 8307.335413166933, 8309.37679674027, 8440.029396619344, 8453.112423195598, 8143.429959902868, 8189.426740128253, 8208.876866847002, 8222.095569487352, 8235.8352832943, 4398.626116780046, 4576.107659006462, 4600.7469589172915, 4683.110209060268, 4815.2054910939305, 1928.9228430862888, 1968.6653268944315, 1981.4154824326858, 1992.551675872946, 1994.4415563642203, 917.4495302818256, 1124.2018167101287, 1128.2835399521364, 1138.5957984915235, 1155.364549497773, 15295.0, 17384.65230695379, 17629.765916385986, 17631.294748209926, 18327.0, 971.4608392342177, 998.6854140945579, 1014.325473560089, 1054.0408228512017, 1056.793925184597, 6404.839879003062, 10185.236107291983, 10395.532201050972, 10649.467526623794, 10999.450027498753, 414389.0, 420696.0, 445153.0, 445789.0, 695667.0, 88661.4535418589, 91902.0, 93527.53236233775, 93555.0, 94387.0, 518.1243698150114, 521.6635270250667, 525.9868503287372, 527.9736013199324, 532.9360476742816, 11147.554097835995, 11159.888401115884, 11370.602028928948, 11382.658520244406, 11441.027512661518, 40073.398899015956, 40626.0, 40756.388654170805, 41427.58572414237, 41639.16721665489, 52890.0, 54003.45996540142, 54586.0, 56948.71525642345, 60465.0, 10302.690919272434, 10436.165106791286, 10448.68653940383, 10454.42500662471, 10455.895441045492, 13877.930610346884, 14665.56003319902, 17969.820301796815, 18878.622427551098, 18920.43238702841, 15855.286512107214, 15947.44183953556, 16129.435469758502, 16325.755113673542, 16572.50282491527, 15888.0, 15893.28480218416, 16034.919825400799, 16102.275397606902, 16243.187840608158, 16225.18874056316, 16275.18624068768, 16442.260098295843, 16483.83516164871, 16830.242639081025, 10480.266381353536, 10635.20235982289, 10690.946545267223, 10768.300060496043, 10768.492411062301, 12849.421776019915, 16036.0, 16096.758548622014, 16198.271077801292, 16212.756808648115], "unit": "ms", "name": "jquery.html", "value": 9155.043625809496}, {"lowerIsBetter": false, "replicates": [1494.940202391904, 1579.6129948162697, 1625.6179797747534, 1768.9203985820636, 1873.9718904216438, 7754.302112809846, 7873.80315492113, 8008.27925486706, 8076.555789431579, 8130.878036829445, 7847.332976696974, 7926.048874135097, 7933.087694915086, 7962.084360298553, 7984.520928744279, 2274.4200228941636, 2311.572359113561, 2315.583195024895, 2322.779335963081, 2324.1633012115626, 2224.8665080095166, 2255.0979608156704, 2268.4442311633675, 2270.795628393444, 2288.1190741564533, 2254.1546919905036, 2274.73840508342, 2278.5898538263104, 2307.4231442139467, 2322.280093171122, 2251.594712951668, 2280.0423821994636, 2328.161861729776, 2328.429534763985, 2335.719713634366, 2307.284741730069, 2314.132200424841, 2337.8012868905994, 2338.275134708246, 2345.4839935214227, 7662.4253181011645, 7747.30274275318, 7759.068911730572, 7780.0, 7794.766157015299, 4563.794629241692, 4626.930596041062, 4656.813727450898, 4672.252439609646, 4684.0, 3009.2176034231256, 3034.089773068071, 3110.3623757129735, 3113.579666744983, 3120.547520609499, 998.0418797953973, 1001.2940876681995, 1714.8885322454125, 1757.2356025129109, 1844.2622950819646, 10595.523201455953, 10670.679879603624, 10679.466026698634, 10692.144628429707, 10716.303440276357, 4022.6379625833815, 4043.8180281887385, 4044.4944381952255, 4076.2458945095254, 4104.507459104927, 8792.60433280504, 8859.424137431175, 8864.601092950832, 8887.466751994902, 8895.822083558292, 4656.3946686930485, 4662.580367766917, 4664.230401983703, 4664.743439110882, 4673.439187297546, 4273.081287523135, 4315.525292217853, 4342.869713908588, 4371.540988196193, 4374.846880359172, 3440.4323286657423, 3463.7575369723877, 3475.6871881530783, 3495.650434956535, 3504.0188747150837, 1037.8287582548946, 1048.8741351037925, 1052.7315534538798, 1056.4031322302874, 1159.171192597297, 1131.5417256011328, 1134.7787181499527, 1137.9658610241706, 1139.8176291793272, 1166.2652528906735, 7207.279272072751, 7522.360599349007, 7555.73554925586, 7566.621668916532, 7594.31651151399, 1166.690826930864, 1181.4506254591656, 1195.3664557784389, 1196.646989138189, 1197.9161458697981, 6036.215292012011, 6075.392460753889, 6116.052011938068, 6116.143739876421, 6130.356312587203, 9042.593083311267, 9550.426974381558, 9596.616135354509, 9617.615295388247, 9633.807323853483, 9488.0, 9535.761605959906, 9541.666041688508, 9551.808963820684, 9643.180329671915, 7228.96385518069, 7465.06686664167, 7487.588182649898, 7516.962415187889, 7517.548947063194, 7081.044059051962, 7337.413006959324, 7351.228121047427, 7367.189609143097, 7388.963055184689, 8445.0, 8559.443636163629, 8573.699920502753, 8605.096464871349, 8627.82744345097, 8513.276371508491, 8636.438631488933, 8647.913520864962, 8667.4366166199, 8713.433626814236, 6885.139357580302, 6914.274001229798, 6967.616781076887, 6974.895376569457, 6984.895226571707, 7628.923710763043, 7701.3068823806125, 7769.184235655175, 7771.339436147765, 7772.494787838772, 6926.134233220848, 7414.184439711519, 7446.7021319146625, 7509.0, 7545.434092442979, 6929.376356127771, 7050.823729406806, 7129.572225666477, 7148.106486689164, 7226.674799633924, 7170.67731952053, 7203.387712044535, 7210.387117095106, 7213.819654508679, 7250.927490725026, 6494.545381823416, 6521.673916304071, 6553.344665533408, 6560.44236239925, 6570.0, 6601.141851559267, 6689.364510371507, 6754.223264324469, 6806.795796125926, 6806.7957961261245], "unit": "ms", "name": "mootools.html", "value": 4583.842770818797}, {"lowerIsBetter": false, "replicates": [356.60416937199705, 362.72614176296906, 364.34054361605513, 365.32050386281514, 366.8972687647458, 6309.053641953709, 6393.488520918327, 6403.167588213531, 6463.83840403989, 6466.256380516242, 6284.780032698856, 6300.810975670737, 6365.363463653633, 6396.072569477423, 6414.166158399413, 4877.0, 4940.4318503372215, 4945.703257804535, 4947.628927830409, 4960.925586116211, 4916.754162291889, 4933.876653083684, 4940.555350018498, 4946.5795407390415, 4948.430930443009, 4659.836905708301, 4807.158747219222, 4814.63890208234, 4820.349252850873, 4831.782569784368, 4856.587190088847, 4856.902861942742, 4857.587105096071, 4865.537773911473, 4879.0, 4237.894052648678, 4240.660747140252, 4244.08752118293, 4250.468691413574, 4252.596003379674, 5969.0, 6037.63774173551, 6049.606775559574, 6053.8183854484, 6060.969695151496, 5653.604247702662, 5657.8019769307875, 5657.830265092054, 5664.773409063632, 5665.263515742969, 6709.228438729511, 6738.427233685143, 6738.629375384352, 6743.426808721265, 6768.289329620417, 4681.180793361183, 4698.953010469886, 4707.741074240916, 4708.270218116163, 4709.340692303081, 6951.826204344881, 7019.5788252705, 7092.361687448154, 7097.89353159703, 7102.644867756643, 4721.622270218374, 4722.527747225318, 4723.220668589713, 4729.6452766042685, 4737.976310118427, 4801.135795556834, 4802.231642937113, 4806.95193048072, 4807.086653535887, 4808.206645903387, 5496.697681627549, 5583.441655834466, 5586.413426590231, 5592.636478628876, 5595.440455954372, 6807.5575087619145, 6812.284710105467, 6813.0, 6814.897776533356, 6824.692888819915, 1650.917454127289, 1718.527404963645, 1721.0878234535717, 1722.3455087066834, 1722.371334462912, 1131.7227279316621, 1136.7442325476702, 1140.8003599370077, 1146.7419830538229, 1149.3965668024355, 6461.515386346043, 6519.348065193538, 6552.148220731275, 6553.770618028346, 6565.868682626321, 6985.720571177198, 7014.158301003912, 7014.22843487216, 7016.824579385454, 7022.719091236396, 6388.776392826228, 6478.157839480931, 6482.643454610042, 6520.641364724891, 6548.738050477928, 3792.639699228569, 3812.4281357796553, 3830.19565891166, 3832.559255685576, 3833.7316387852584, 7197.748078817216, 7223.133224013152, 7229.638518074075, 7238.927610723826, 7242.45681573884, 7078.292170782881, 7173.246809085075, 7204.603746793977, 7206.675699593426, 7305.5981920994855, 7348.375388091965, 7352.04423424962, 7366.926330736624, 7370.44721645868, 7370.668319925616, 7129.394001509722, 7137.500374973702, 7148.85702285941, 7154.570725756471, 7155.785326440215, 6856.348646878539, 7000.334968178015, 7011.859762804817, 7021.1574611047, 7044.225135235018, 7240.420766338786, 7274.599897005715, 7308.5614863108385, 7336.7432139874845, 7342.706291748484, 4737.526247375235, 4768.904621907473, 4774.928376074431, 4777.211760059551, 4778.04439112172, 6894.551854129466, 6970.581765093908, 7055.506114571931, 7145.4998150128995, 7149.034880291094, 6776.254611992578, 6895.4138898194215, 6927.272636373108, 6942.930570694229, 6945.687444064928, 6877.243503214742, 6894.413974812197, 6902.8619427612175, 6912.066870972354, 6923.826904327432, 6652.168478940132, 6708.765193218214, 6771.153605799275, 6782.084418603426, 6783.253842077466, 6880.518363714492, 6949.7567585134275, 6965.477589180933, 6967.616781077089, 6968.616726080114, 6670.199576050905, 6757.391834734701, 6759.864802704017, 6762.222344430256, 6764.86470270582], "unit": "ms", "name": "prototype.html", "value": 5129.401158773778}, {"lowerIsBetter": false, "replicates": [827.2843989948697, 854.209855883308, 889.0131953531579, 914.2685851318943, 916.5325683901212, 14663.486777962773, 14720.77918831217, 14774.261286935636, 14820.258987050645, 14900.403983840646, 12752.0, 14306.141631502118, 14334.784978225334, 14373.137611743303, 14401.711965760678, 903.1735961595149, 910.4218821048615, 914.8856392950881, 915.1809130827938, 916.225789208118, 910.4992254260163, 913.6665117232229, 920.894097178823, 921.1433366968716, 923.9445633261993, 970.2383628851353, 970.7621632699999, 973.4062222044547, 978.1196922769493, 978.4373984958642, 968.1528662420383, 971.640493017581, 972.5866506734609, 973.8831340239146, 976.2531663277598, 709.8651256261345, 715.1275443958363, 719.4316489972967, 719.5790462579397, 720.7585458871284, 14479.78280325796, 14483.493077742229, 14570.271486425743, 14603.70792584153, 14612.926935365254, 12914.547990820276, 13095.803562946563, 13118.344082795822, 13718.588442346745, 14204.0, 10050.547725352377, 11572.652820415316, 11719.296842189411, 11826.645200643994, 12111.818322725167, 3886.24218277436, 3939.2515422069714, 3966.186931678999, 4033.092554175287, 4085.305498065336, 47416.0, 48303.27545086826, 48727.269090964015, 48811.267830982564, 53935.0, 10790.51442685081, 10938.56245750161, 10953.726156845983, 11061.834072488919, 11253.268537545033, 19208.903955480135, 19291.4212573623, 19301.61396772085, 19307.131179096974, 19384.321548745727, 7796.571188584682, 8166.591670416456, 8255.545944972964, 8300.460470069425, 8461.915380846112, 4669.929951050737, 4688.57802797743, 4752.904941901143, 4799.3760811094335, 4811.879703007453, 3238.8380580970856, 3299.6700329967293, 3389.254364039907, 3470.340635279289, 3477.009052420048, 596.150485558078, 613.5950272819917, 616.3528295289927, 620.4416025577017, 628.5788521690479, 720.1574158234878, 721.3760097515716, 734.203389322591, 758.9316961473494, 760.3536993555433, 9075.092490751003, 9252.629894804133, 9345.112214339626, 9394.906050939404, 9536.475493847905, 701.4528667639249, 709.3686618909175, 724.6920058974914, 733.4609062339176, 738.5162718419443, 4395.912081758347, 4396.988692600719, 4403.251447253974, 4487.64098872096, 4582.1293954148605, 58551.70724146352, 61423.6928815362, 61710.0, 61887.0, 62138.37861621326, 47981.280280795814, 48923.0, 53327.0, 54536.0, 54785.45214547803, 52780.47219527756, 53375.0, 54384.0, 55008.0, 55865.44134558603, 8982.281417486716, 9069.682561110329, 9507.809843803223, 9824.4105353679, 9836.311458197857, 37069.81465092657, 38195.236095278495, 38296.61703383042, 38769.6123038766, 39377.80311098426, 44164.55835441733, 46157.30764038475, 49419.50580494293, 49833.75083124561, 49862.0, 11250.0, 11531.596394126165, 11721.941390292994, 12260.325682087214, 12356.073294502768, 12016.519339226683, 12438.129330946747, 12590.0, 12693.746125077632, 13281.402336895057, 11824.40877956116, 12434.502619895466, 12531.624051278111, 12606.243625382507, 13172.143810652276, 11568.537258509565, 11571.247868888495, 11692.766144676889, 11835.644930652094, 12274.324912129918, 12151.088668350087, 12294.077944154045, 12374.81437778452, 12650.177738446971, 12704.74590508203, 9934.801303973736, 10341.327813692085, 10895.400752958663, 10951.0, 11352.148588856035, 9955.50222488887, 10392.636257730943, 10486.632967846088, 10575.841362379724, 10589.788204236027], "unit": "ms", "name": "yui.html", "value": 6900.880288638169}], "name": "dromaeo_css", "value": 7371.692499802285}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 108.0, 112.0, 110.0, 113.0, 122.0, 112.0, 112.0, 111.0, 113.0], "unit": "ms", "name": "ai-astar", "value": 112.4}, {"lowerIsBetter": true, "replicates": [146.0, 122.0, 146.0, 161.0, 123.0, 158.0, 157.0, 124.0, 158.0, 122.0], "unit": "ms", "name": "audio-beat-detection", "value": 141.7}, {"lowerIsBetter": true, "replicates": [162.0, 164.0, 162.0, 163.0, 163.0, 164.0, 162.0, 161.0, 168.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 163.1}, {"lowerIsBetter": true, "replicates": [78.0, 72.0, 75.0, 156.0, 72.0, 71.0, 71.0, 73.0, 159.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 89.9}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 137.0, 101.0, 94.0, 93.0, 138.0, 92.0, 92.0, 130.0], "unit": "ms", "name": "audio-oscillator", "value": 106.1}, {"lowerIsBetter": true, "replicates": [111.0, 110.0, 110.0, 110.0, 110.0, 109.0, 109.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [149.0, 147.0, 147.0, 148.0, 150.0, 148.0, 148.0, 147.0, 150.0, 148.0], "unit": "ms", "name": "imaging-darkroom", "value": 148.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 99.0, 96.0, 97.0, 98.0, 97.0, 96.0, 96.0, 99.0], "unit": "ms", "name": "imaging-desaturate", "value": 97.0}, {"lowerIsBetter": true, "replicates": [59.0, 63.0, 61.0, 58.0, 59.0, 59.0, 62.0, 58.0, 56.0, 57.0], "unit": "ms", "name": "json-parse-financial", "value": 59.2}, {"lowerIsBetter": true, "replicates": [62.0, 74.0, 63.0, 64.0, 64.0, 64.0, 64.0, 63.0, 63.0, 64.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 64.5}, {"lowerIsBetter": true, "replicates": [80.0, 81.0, 88.0, 89.0, 81.0, 89.0, 81.0, 80.0, 82.0, 82.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 83.3}, {"lowerIsBetter": true, "replicates": [114.0, 122.0, 114.0, 120.0, 114.0, 120.0, 111.0, 121.0, 115.0, 127.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 117.8}, {"lowerIsBetter": true, "replicates": [140.0, 146.0, 148.0, 148.0, 140.0, 148.0, 141.0, 146.0, 149.0, 140.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 144.6}, {"lowerIsBetter": true, "replicates": [64.0, 66.0, 66.0, 69.0, 68.0, 66.0, 70.0, 67.0, 71.0, 65.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 67.2}], "name": "kraken", "value": 1504.8999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.26194017517767], "unit": "score", "name": "Richards", "value": 213.61240199999997}, {"lowerIsBetter": false, "replicates": [173.16017316017317], "unit": "score", "name": "DeltaBlue", "value": 381.83144999999985}, {"lowerIsBetter": false, "replicates": [278.55153203342616], "unit": "score", "name": "Encrypt", "value": 955.5897900000004}, {"lowerIsBetter": false, "replicates": [5143.589743589743], "unit": "score", "name": "Decrypt", "value": 51.75004486540379}, {"lowerIsBetter": false, "replicates": [930.2325581395348], "unit": "score", "name": "RayTrace", "value": 795.4881749999996}, {"lowerIsBetter": false, "replicates": [542.5935973955508], "unit": "score", "name": "Earley", "value": 1228.2913090000002}, {"lowerIsBetter": false, "replicates": [11010.989010989011], "unit": "score", "name": "Boyer", "value": 60.527078842315376}, {"lowerIsBetter": false, "replicates": [24047.619047619046], "unit": "score", "name": "RegExp", "value": 37.88254455445545}, {"lowerIsBetter": false, "replicates": [514.668039114771], "unit": "score", "name": "Splay", "value": 158.33701299999998}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 23223.653691274136}]} 11:43:03 INFO - RETURN: dromaeo_css: 7371.69 11:43:03 INFO - RETURN: kraken: 1504.90 11:43:03 INFO - RETURN: v8_7: 23223.65 11:43:03 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "23223.65"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1504.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7371.69"}}} 11:43:03 INFO - Return code: 0 11:43:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:43:03 INFO - # TBPL SUCCESS # 11:43:03 INFO - Running post-action listener: _resource_record_post_action 11:43:03 INFO - Running post-run listener: _resource_record_post_run 11:43:04 INFO - Total resource usage - Wall time: 1223s; CPU: 13.0%; Read bytes: 0; Write bytes: 500379648; Read time: 0; Write time: 332372 11:43:04 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 235651072; Read time: 0; Write time: 192376 11:43:04 INFO - run-tests - Wall time: 1208s; CPU: 13.0%; Read bytes: 0; Write bytes: 264728576; Read time: 0; Write time: 139996 11:43:04 INFO - Running post-run listener: _upload_blobber_files 11:43:04 INFO - Blob upload gear active. 11:43:04 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 11:43:04 INFO - Copying logs to upload dir... 11:43:04 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1262.521584 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-01-25 11:43:03.375289) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-25 11:43:03.378852) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1453749720.413366-2082337915 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009904 build_url: 'https://queue.taskcluster.net/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-25 11:43:03.433339) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:43:03.433656) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1453749720.413366-2082337915 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004480 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:43:03.483434) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 11:43:03.483746) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 11:43:03.484054) ========= ========= Total master_lag: 0.26 =========