builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-057 starttime: 1453749719.13 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.130144) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 11:21:59.130700) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 11:21:59.130987) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=934fc3100db09dcb9af4d4b6000001ab-1453749719.569958-536710323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006242 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.07 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 11:21:59.210383) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 11:21:59.210689) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 11:21:59.224630) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:21:59.224932) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=934fc3100db09dcb9af4d4b6000001ab-1453749719.569958-536710323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004507 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:21:59.277077) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 11:21:59.277347) ========= 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.277676) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:21:59.277941) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=934fc3100db09dcb9af4d4b6000001ab-1453749719.569958-536710323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-25 11:22:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 218M=0s 2016-01-25 11:22:00 (218 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.180825 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:21:59.470316) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:21:59.470619) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=934fc3100db09dcb9af4d4b6000001ab-1453749719.569958-536710323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018730 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:21:59.519757) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:21:59.520055) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1453749719.569958-536710323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-25 11:22:00,857 truncating revision to first 12 chars 2016-01-25 11:22:00,857 Setting DEBUG logging. 2016-01-25 11:22:00,857 attempt 1/10 2016-01-25 11:22:00,857 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,511 unpacking tar archive at: mozilla-aurora-3bfa5bc61b62/testing/mozharness/ program finished with exit code 0 elapsedTime=0.949032 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:22:00.482928) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 11:22:00.483259) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1453749719.569958-536710323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 3bfa5bc61b626761d487b45c170b115259f69d6b program finished with exit code 0 elapsedTime=0.004651 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.534140) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 11:22:00.534502) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 11:22:00.544522) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-01-25 11:22:00.544889) ========= /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=934fc3100db09dcb9af4d4b6000001ab-1453749719.569958-536710323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:22:01 INFO - MultiFileLogger online at 20160125 11:22:01 in /builds/slave/test-pgo 11:22:01 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:01 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 11:22:01 INFO - {'append_to_log': False, 11:22:01 INFO - 'base_work_dir': '/builds/slave/test-pgo', 11:22:01 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:22:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 11:22:01 INFO - 'branch': 'Mozilla-Aurora', 11:22:01 INFO - 'buildbot_json_path': 'buildprops.json', 11:22:01 INFO - 'config_files': ('talos/linux_config.py',), 11:22:01 INFO - 'default_actions': ('clobber', 11:22:01 INFO - 'read-buildbot-config', 11:22:01 INFO - 'download-and-extract', 11:22:01 INFO - 'populate-webroot', 11:22:01 INFO - 'create-virtualenv', 11:22:01 INFO - 'install', 11:22:01 INFO - 'run-tests'), 11:22:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:22:01 INFO - 'download_minidump_stackwalk': True, 11:22:01 INFO - 'download_symbols': 'ondemand', 11:22:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:22:01 INFO - 'tooltool.py': '/tools/tooltool.py', 11:22:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:22:01 INFO - '/tools/misc-python/virtualenv.py')}, 11:22:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:22:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:22:01 INFO - 'installer_path': 'installer.exe', 11:22:01 INFO - 'log_level': 'info', 11:22:01 INFO - 'log_name': 'talos', 11:22:01 INFO - 'log_to_console': True, 11:22:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:22:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:22:01 INFO - 'opt_config_files': (), 11:22:01 INFO - 'pip_index': False, 11:22:01 INFO - 'sps_profile': False, 11:22:01 INFO - 'sps_profile_interval': 0, 11:22:01 INFO - 'suite': 'dromaeojs-e10s', 11:22:01 INFO - 'system_bits': '32', 11:22:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:22:01 INFO - 'title': 'talos-linux64-ix-057', 11:22:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:22:01 INFO - 'use_talos_json': True, 11:22:01 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 11:22:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:22:01 INFO - 'work_dir': 'build'} 11:22:01 INFO - ##### 11:22:01 INFO - ##### Running clobber step. 11:22:01 INFO - ##### 11:22:01 INFO - Running pre-action listener: _resource_record_pre_action 11:22:01 INFO - Running main action method: clobber 11:22:01 INFO - rmtree: /builds/slave/test-pgo/build 11:22:01 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": 15, 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-057", 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-master104.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:03 INFO - Downloaded 1302 bytes. 11:22:03 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 11:22:03 INFO - Using the following test package requirements: 11:22:03 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 11:22:03 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:22:03 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 11:22:03 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:22:03 INFO - u'jsshell-linux-x86_64.zip'], 11:22:03 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:22:03 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 11:22:03 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 11:22:03 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:22:03 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 11:22:03 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:22:03 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 11:22:03 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:22:03 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 11:22:03 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 11:22:03 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:22:03 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 11:22:03 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:22:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:03 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:03 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:03 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:03 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:03 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:04 INFO - Downloaded 21579043 bytes. 11:22:04 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:04 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:22:04 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:05 INFO - Return code: 0 11:22:05 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: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:07 INFO - Downloaded 21579043 bytes. 11:22:07 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:07 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:22:07 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:08 INFO - Return code: 0 11:22:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:08 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:08 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:08 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:08 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:08 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:13 INFO - Downloaded 11132038 bytes. 11:22:13 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:13 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 11:22:13 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:14 INFO - Return code: 0 11:22:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:14 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:14 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:14 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:14 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:14 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:16 INFO - Downloaded 58070235 bytes. 11:22:16 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:16 INFO - mkdir: /builds/slave/test-pgo/properties 11:22:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 11:22:16 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 11:22:16 INFO - Contents: 11:22:16 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:16 INFO - Running post-action listener: _resource_record_post_action 11:22:16 INFO - Running post-action listener: set_extra_try_arguments 11:22:16 INFO - ##### 11:22:16 INFO - ##### Running populate-webroot step. 11:22:16 INFO - ##### 11:22:16 INFO - Running pre-action listener: _resource_record_pre_action 11:22:16 INFO - Running main action method: populate_webroot 11:22:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:22:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:22:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:22:16 INFO - '--tppagecycles', 11:22:16 INFO - '7'], 11:22:16 INFO - 'tests': ['tsvgm']}}, 11:22:16 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:22:16 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:22:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:22:16 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:22:16 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:22:16 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:22:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:22:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:16 INFO - 'talos_options': ['--e10s'], 11:22:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:22:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:16 INFO - 'tests': ['damp', 'tps']}, 11:22:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:16 INFO - 'talos_options': ['--e10s'], 11:22:16 INFO - 'tests': ['damp', 'tps']}, 11:22:16 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:22:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:22:16 INFO - 'other': {'tests': ['a11yr', 11:22:16 INFO - 'ts_paint', 11:22:16 INFO - 'tpaint', 11:22:16 INFO - 'sessionrestore', 11:22:16 INFO - 'sessionrestore_no_auto_restore']}, 11:22:16 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:22:16 INFO - 'tests': ['a11yr', 11:22:16 INFO - 'ts_paint', 11:22:16 INFO - 'tpaint', 11:22:16 INFO - 'sessionrestore', 11:22:16 INFO - 'sessionrestore_no_auto_restore']}, 11:22:16 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:22:16 INFO - 'tests': ['a11yr', 11:22:16 INFO - 'ts_paint', 11:22:16 INFO - 'tpaint', 11:22:16 INFO - 'sessionrestore', 11:22:16 INFO - 'sessionrestore_no_auto_restore']}, 11:22:16 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:22:16 INFO - 'tests': ['a11yr', 11:22:16 INFO - 'ts_paint', 11:22:16 INFO - 'tpaint', 11:22:16 INFO - 'sessionrestore', 11:22:16 INFO - 'sessionrestore_no_auto_restore']}, 11:22:16 INFO - 'other_l64': {'tests': ['a11yr', 11:22:16 INFO - 'ts_paint', 11:22:16 INFO - 'tpaint', 11:22:16 INFO - 'sessionrestore', 11:22:16 INFO - 'sessionrestore_no_auto_restore']}, 11:22:16 INFO - 'other_nol64': {'tests': ['a11yr', 11:22:16 INFO - 'ts_paint', 11:22:16 INFO - 'tpaint', 11:22:16 INFO - 'sessionrestore', 11:22:16 INFO - 'sessionrestore_no_auto_restore']}, 11:22:16 INFO - 'svgr': {'tests': ['tsvgx', 11:22:16 INFO - 'tsvgr_opacity', 11:22:16 INFO - 'tart', 11:22:16 INFO - 'tscrollx', 11:22:16 INFO - 'cart']}, 11:22:16 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:22:16 INFO - 'tests': ['tsvgx', 11:22:16 INFO - 'tsvgr_opacity', 11:22:16 INFO - 'tart', 11:22:16 INFO - 'tscrollx', 11:22:16 INFO - 'cart']}, 11:22:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:16 INFO - 'tests': ['tp5o']}, 11:22:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:16 INFO - 'talos_options': ['--e10s'], 11:22:16 INFO - 'tests': ['tp5o']}, 11:22:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:16 INFO - 'talos_options': ['--xperf_path', 11:22:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:22:16 INFO - 'tests': ['tp5n']}, 11:22:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:16 INFO - 'talos_options': ['--e10s', 11:22:16 INFO - '--xperf_path', 11:22:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:22:16 INFO - 'tests': ['tp5n']}}, 11:22:16 INFO - 'talos.zip': {'path': '', 11:22:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:22:16 INFO - Running post-action listener: _resource_record_post_action 11:22:16 INFO - ##### 11:22:16 INFO - ##### Running create-virtualenv step. 11:22:16 INFO - ##### 11:22:16 INFO - Running pre-action listener: _resource_record_pre_action 11:22:16 INFO - Running main action method: create_virtualenv 11:22:16 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 11:22:16 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:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 11:22:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:22:16 INFO - Using real prefix '/usr' 11:22:16 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 11:22:16 INFO - Installing distribute.............................................................................................................................................................................................done. 11:22:18 INFO - Installing pip.................done. 11:22:18 INFO - Return code: 0 11:22:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 11:22:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:18 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e3537ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2987450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a19a50>, '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 0x2985550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29859e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1453749719.569958-536710323', '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:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 11:22:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:22:18 INFO - Using env: {'DISPLAY': ':0', 11:22:18 INFO - 'HOME': '/home/cltbld', 11:22:18 INFO - 'LANG': 'en_US.UTF-8', 11:22:18 INFO - 'LANGUAGE': 'en_US:en', 11:22:18 INFO - 'LOGNAME': 'cltbld', 11:22:18 INFO - 'MAIL': '/var/mail/cltbld', 11:22:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:18 INFO - 'MOZ_NO_REMOTE': '1', 11:22:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:18 INFO - 'NO_EM_RESTART': '1', 11:22:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:22:18 INFO - 'PWD': '/builds/slave/test-pgo', 11:22:18 INFO - 'SHELL': '/bin/bash', 11:22:18 INFO - 'SHLVL': '1', 11:22:18 INFO - 'TERM': 'linux', 11:22:18 INFO - 'TMOUT': '86400', 11:22:18 INFO - 'USER': 'cltbld', 11:22:18 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1453749719.569958-536710323', 11:22:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:18 INFO - '_': '/tools/buildbot/bin/python'} 11:22:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:18 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:18 INFO - Cleaning up... 11:22:18 INFO - Return code: 0 11:22:18 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 11:22:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:18 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8e3537ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2987450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a19a50>, '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 0x2985550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29859e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1453749719.569958-536710323', '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:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 11:22:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 11:22:18 INFO - Using env: {'DISPLAY': ':0', 11:22:18 INFO - 'HOME': '/home/cltbld', 11:22:18 INFO - 'LANG': 'en_US.UTF-8', 11:22:18 INFO - 'LANGUAGE': 'en_US:en', 11:22:18 INFO - 'LOGNAME': 'cltbld', 11:22:18 INFO - 'MAIL': '/var/mail/cltbld', 11:22:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:18 INFO - 'MOZ_NO_REMOTE': '1', 11:22:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:18 INFO - 'NO_EM_RESTART': '1', 11:22:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:22:18 INFO - 'PWD': '/builds/slave/test-pgo', 11:22:18 INFO - 'SHELL': '/bin/bash', 11:22:18 INFO - 'SHLVL': '1', 11:22:18 INFO - 'TERM': 'linux', 11:22:18 INFO - 'TMOUT': '86400', 11:22:18 INFO - 'USER': 'cltbld', 11:22:18 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1453749719.569958-536710323', 11:22:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:18 INFO - '_': '/tools/buildbot/bin/python'} 11:22:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:19 INFO - Downloading/unpacking psutil>=0.7.1 11:22:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 11:22:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:22:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:22:20 INFO - Installing collected packages: psutil 11:22:20 INFO - Running setup.py install for psutil 11:22:20 INFO - building 'psutil._psutil_linux' extension 11:22:20 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:21 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:21 INFO - building 'psutil._psutil_posix' extension 11:22:21 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:21 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:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:22:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:22:21 INFO - Successfully installed psutil 11:22:21 INFO - Cleaning up... 11:22:21 INFO - Return code: 0 11:22:21 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 11:22:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:21 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 0x7f8e3537ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2987450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a19a50>, '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 0x2985550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29859e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1453749719.569958-536710323', '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:21 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:21 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:21 INFO - Using env: {'DISPLAY': ':0', 11:22:21 INFO - 'HOME': '/home/cltbld', 11:22:21 INFO - 'LANG': 'en_US.UTF-8', 11:22:21 INFO - 'LANGUAGE': 'en_US:en', 11:22:21 INFO - 'LOGNAME': 'cltbld', 11:22:21 INFO - 'MAIL': '/var/mail/cltbld', 11:22:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:21 INFO - 'MOZ_NO_REMOTE': '1', 11:22:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:21 INFO - 'NO_EM_RESTART': '1', 11:22:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:22:21 INFO - 'PWD': '/builds/slave/test-pgo', 11:22:21 INFO - 'SHELL': '/bin/bash', 11:22:21 INFO - 'SHLVL': '1', 11:22:21 INFO - 'TERM': 'linux', 11:22:21 INFO - 'TMOUT': '86400', 11:22:21 INFO - 'USER': 'cltbld', 11:22:21 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1453749719.569958-536710323', 11:22:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:21 INFO - '_': '/tools/buildbot/bin/python'} 11:22:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:21 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:22:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:22:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:22:23 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:23 INFO - Installing collected packages: mozsystemmonitor 11:22:23 INFO - Running setup.py install for mozsystemmonitor 11:22:23 INFO - Successfully installed mozsystemmonitor 11:22:23 INFO - Cleaning up... 11:22:23 INFO - Return code: 0 11:22:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 11:22:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:23 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 0x7f8e3537ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2987450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a19a50>, '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 0x2985550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29859e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1453749719.569958-536710323', '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:23 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:23 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:23 INFO - Using env: {'DISPLAY': ':0', 11:22:23 INFO - 'HOME': '/home/cltbld', 11:22:23 INFO - 'LANG': 'en_US.UTF-8', 11:22:23 INFO - 'LANGUAGE': 'en_US:en', 11:22:23 INFO - 'LOGNAME': 'cltbld', 11:22:23 INFO - 'MAIL': '/var/mail/cltbld', 11:22:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:23 INFO - 'MOZ_NO_REMOTE': '1', 11:22:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:23 INFO - 'NO_EM_RESTART': '1', 11:22:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:22:23 INFO - 'PWD': '/builds/slave/test-pgo', 11:22:23 INFO - 'SHELL': '/bin/bash', 11:22:23 INFO - 'SHLVL': '1', 11:22:23 INFO - 'TERM': 'linux', 11:22:23 INFO - 'TMOUT': '86400', 11:22:23 INFO - 'USER': 'cltbld', 11:22:23 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1453749719.569958-536710323', 11:22:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:23 INFO - '_': '/tools/buildbot/bin/python'} 11:22:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:23 INFO - Downloading/unpacking blobuploader==1.2.4 11:22:23 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:23 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:23 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:23 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:23 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:23 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 - Downloading blobuploader-1.2.4.tar.gz 11:22:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:22:25 INFO - Downloading/unpacking requests==1.2.3. (from 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:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 11:22:26 INFO - Downloading/unpacking docopt==0.6.1 (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:26 INFO - Downloading docopt-0.6.1.tar.gz 11:22:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 11:22:26 INFO - Installing collected packages: blobuploader, requests, docopt 11:22:26 INFO - Running setup.py install for blobuploader 11:22:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:22:26 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 11:22:26 INFO - Running setup.py install for requests 11:22:26 INFO - Running setup.py install for docopt 11:22:26 INFO - Successfully installed blobuploader requests docopt 11:22:26 INFO - Cleaning up... 11:22:27 INFO - Return code: 0 11:22:27 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:22:27 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:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:27 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:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:27 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 0x7f8e3537ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2987450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a19a50>, '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 0x2985550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29859e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1453749719.569958-536710323', '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:27 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:27 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:27 INFO - Using env: {'DISPLAY': ':0', 11:22:27 INFO - 'HOME': '/home/cltbld', 11:22:27 INFO - 'LANG': 'en_US.UTF-8', 11:22:27 INFO - 'LANGUAGE': 'en_US:en', 11:22:27 INFO - 'LOGNAME': 'cltbld', 11:22:27 INFO - 'MAIL': '/var/mail/cltbld', 11:22:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:27 INFO - 'MOZ_NO_REMOTE': '1', 11:22:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:27 INFO - 'NO_EM_RESTART': '1', 11:22:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:22:27 INFO - 'PWD': '/builds/slave/test-pgo', 11:22:27 INFO - 'SHELL': '/bin/bash', 11:22:27 INFO - 'SHLVL': '1', 11:22:27 INFO - 'TERM': 'linux', 11:22:27 INFO - 'TMOUT': '86400', 11:22:27 INFO - 'USER': 'cltbld', 11:22:27 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1453749719.569958-536710323', 11:22:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:27 INFO - '_': '/tools/buildbot/bin/python'} 11:22:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:22:27 INFO - Running setup.py (path:/tmp/pip-nnsc_Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:22:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:22:27 INFO - Running setup.py (path:/tmp/pip-SWE5gw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:22:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:22:27 INFO - Running setup.py (path:/tmp/pip-U3nQvW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:22:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:22:27 INFO - Running setup.py (path:/tmp/pip-qbKJnR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:22:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:22:27 INFO - Running setup.py (path:/tmp/pip-XJJfzW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:22:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:22:27 INFO - Running setup.py (path:/tmp/pip-iIkRmB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:22:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:22:27 INFO - Running setup.py (path:/tmp/pip-lUYFex-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:22:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:22:27 INFO - Running setup.py (path:/tmp/pip-78zNPJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:22:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:22:27 INFO - Running setup.py (path:/tmp/pip-LiH2a1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:22:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:22:27 INFO - Running setup.py (path:/tmp/pip-MqoOSi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:22:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:22:27 INFO - Running setup.py (path:/tmp/pip-ajN2cU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:22:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:22:28 INFO - Running setup.py (path:/tmp/pip-v8r5O8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:22:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:22:28 INFO - Running setup.py (path:/tmp/pip-vSJ9P3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:22:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:22:28 INFO - Running setup.py (path:/tmp/pip-zaqWaX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:22:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:22:28 INFO - Running setup.py (path:/tmp/pip-icdB4w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:22:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:22:28 INFO - Running setup.py (path:/tmp/pip-koYh13-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:22:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:22:28 INFO - Running setup.py (path:/tmp/pip-ONjoKU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:22:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:22:28 INFO - Running setup.py install for manifestparser 11:22:28 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 11:22:28 INFO - Running setup.py install for mozcrash 11:22:28 INFO - Running setup.py install for mozdebug 11:22:28 INFO - Running setup.py install for mozdevice 11:22:28 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 11:22:28 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 11:22:28 INFO - Running setup.py install for mozfile 11:22:28 INFO - Running setup.py install for mozhttpd 11:22:29 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 11:22:29 INFO - Running setup.py install for mozinfo 11:22:29 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 11:22:29 INFO - Running setup.py install for mozInstall 11:22:29 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 11:22:29 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 11:22:29 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 11:22:29 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 11:22:29 INFO - Running setup.py install for mozleak 11:22:29 INFO - Running setup.py install for mozlog 11:22:29 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 11:22:29 INFO - Running setup.py install for moznetwork 11:22:29 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 11:22:29 INFO - Running setup.py install for mozprocess 11:22:29 INFO - Running setup.py install for mozprofile 11:22:29 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 11:22:29 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 11:22:29 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 11:22:29 INFO - Running setup.py install for mozrunner 11:22:29 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 11:22:29 INFO - Running setup.py install for mozscreenshot 11:22:30 INFO - Running setup.py install for moztest 11:22:30 INFO - Running setup.py install for mozversion 11:22:30 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 11:22:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:22:30 INFO - Cleaning up... 11:22:30 INFO - Return code: 0 11:22:30 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:22:30 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:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:30 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:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:30 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 0x7f8e3537ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2987450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a19a50>, '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 0x2985550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29859e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1453749719.569958-536710323', '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:30 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:30 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:30 INFO - Using env: {'DISPLAY': ':0', 11:22:30 INFO - 'HOME': '/home/cltbld', 11:22:30 INFO - 'LANG': 'en_US.UTF-8', 11:22:30 INFO - 'LANGUAGE': 'en_US:en', 11:22:30 INFO - 'LOGNAME': 'cltbld', 11:22:30 INFO - 'MAIL': '/var/mail/cltbld', 11:22:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:30 INFO - 'MOZ_NO_REMOTE': '1', 11:22:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:30 INFO - 'NO_EM_RESTART': '1', 11:22:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:22:30 INFO - 'PWD': '/builds/slave/test-pgo', 11:22:30 INFO - 'SHELL': '/bin/bash', 11:22:30 INFO - 'SHLVL': '1', 11:22:30 INFO - 'TERM': 'linux', 11:22:30 INFO - 'TMOUT': '86400', 11:22:30 INFO - 'USER': 'cltbld', 11:22:30 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1453749719.569958-536710323', 11:22:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:30 INFO - '_': '/tools/buildbot/bin/python'} 11:22:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:22:30 INFO - Running setup.py (path:/tmp/pip-few3JQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:22:30 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:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:22:30 INFO - Running setup.py (path:/tmp/pip-zdExXy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:22:30 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:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:22:30 INFO - Running setup.py (path:/tmp/pip-jFh0rv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:22:30 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:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:22:30 INFO - Running setup.py (path:/tmp/pip-xBm61g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:22:30 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:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:22:30 INFO - Running setup.py (path:/tmp/pip-Rd_5k2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:22:30 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:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:22:30 INFO - Running setup.py (path:/tmp/pip-sTAun3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:22:30 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:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:22:30 INFO - Running setup.py (path:/tmp/pip-eJAi1m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:22:30 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:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:22:30 INFO - Running setup.py (path:/tmp/pip-KPtato-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:22:31 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:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:22:31 INFO - Running setup.py (path:/tmp/pip-QFhDhj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:22:31 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:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:22:31 INFO - Running setup.py (path:/tmp/pip-6lp8IP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:22:31 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:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:22:31 INFO - Running setup.py (path:/tmp/pip-9RJsZo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:22:31 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:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:22:31 INFO - Running setup.py (path:/tmp/pip-KDtSiP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:22:31 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:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:22:31 INFO - Running setup.py (path:/tmp/pip-KQ3dPp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:22:31 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:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:22:31 INFO - Running setup.py (path:/tmp/pip-ZSNSUi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:22:31 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:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:22:31 INFO - Running setup.py (path:/tmp/pip-CCDmb9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:22:31 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:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:22:31 INFO - Running setup.py (path:/tmp/pip-bn6dFb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:22:31 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:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:22:31 INFO - Running setup.py (path:/tmp/pip-kakRqi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:22:31 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:31 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:31 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:31 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:31 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:31 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:31 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:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:33 INFO - Downloading blessings-1.6.tar.gz 11:22:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 11:22:33 INFO - Installing collected packages: blessings 11:22:33 INFO - Running setup.py install for blessings 11:22:33 INFO - Successfully installed blessings 11:22:33 INFO - Cleaning up... 11:22:33 INFO - Return code: 0 11:22:33 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 11:22:33 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:22:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:22:33 INFO - Reading from file tmpfile_stdout 11:22:33 INFO - Current package versions: 11:22:33 INFO - argparse == 1.2.1 11:22:33 INFO - blessings == 1.6 11:22:33 INFO - blobuploader == 1.2.4 11:22:33 INFO - docopt == 0.6.1 11:22:33 INFO - manifestparser == 1.1 11:22:33 INFO - mozInstall == 1.12 11:22:33 INFO - mozcrash == 0.16 11:22:33 INFO - mozdebug == 0.1 11:22:33 INFO - mozdevice == 0.47 11:22:33 INFO - mozfile == 1.2 11:22:33 INFO - mozhttpd == 0.7 11:22:33 INFO - mozinfo == 0.9 11:22:33 INFO - mozleak == 0.1 11:22:33 INFO - mozlog == 3.1 11:22:33 INFO - moznetwork == 0.27 11:22:33 INFO - mozprocess == 0.22 11:22:33 INFO - mozprofile == 0.27 11:22:33 INFO - mozrunner == 6.11 11:22:33 INFO - mozscreenshot == 0.1 11:22:33 INFO - mozsystemmonitor == 0.0 11:22:33 INFO - moztest == 0.7 11:22:33 INFO - mozversion == 1.4 11:22:33 INFO - psutil == 3.1.1 11:22:33 INFO - requests == 1.2.3 11:22:33 INFO - wsgiref == 0.1.2 11:22:33 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:22:33 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:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:33 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:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:33 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 0x7f8e3537ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2987450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a19a50>, '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 0x2985550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29859e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1453749719.569958-536710323', '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:33 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:33 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:33 INFO - Using env: {'DISPLAY': ':0', 11:22:33 INFO - 'HOME': '/home/cltbld', 11:22:33 INFO - 'LANG': 'en_US.UTF-8', 11:22:33 INFO - 'LANGUAGE': 'en_US:en', 11:22:33 INFO - 'LOGNAME': 'cltbld', 11:22:33 INFO - 'MAIL': '/var/mail/cltbld', 11:22:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:33 INFO - 'MOZ_NO_REMOTE': '1', 11:22:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:33 INFO - 'NO_EM_RESTART': '1', 11:22:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:22:33 INFO - 'PWD': '/builds/slave/test-pgo', 11:22:33 INFO - 'SHELL': '/bin/bash', 11:22:33 INFO - 'SHLVL': '1', 11:22:33 INFO - 'TERM': 'linux', 11:22:33 INFO - 'TMOUT': '86400', 11:22:33 INFO - 'USER': 'cltbld', 11:22:33 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1453749719.569958-536710323', 11:22:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:33 INFO - '_': '/tools/buildbot/bin/python'} 11:22:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:34 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:34 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:34 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:34 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:34 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:34 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:34 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:34 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:34 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:34 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:34 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:34 INFO - Cleaning up... 11:22:34 INFO - Return code: 0 11:22:34 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 11:22:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:34 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 0x7f8e3537ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2987450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a19a50>, '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 0x2985550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29859e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1453749719.569958-536710323', '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:34 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:34 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:34 INFO - Using env: {'DISPLAY': ':0', 11:22:34 INFO - 'HOME': '/home/cltbld', 11:22:34 INFO - 'LANG': 'en_US.UTF-8', 11:22:34 INFO - 'LANGUAGE': 'en_US:en', 11:22:34 INFO - 'LOGNAME': 'cltbld', 11:22:34 INFO - 'MAIL': '/var/mail/cltbld', 11:22:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:34 INFO - 'MOZ_NO_REMOTE': '1', 11:22:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:34 INFO - 'NO_EM_RESTART': '1', 11:22:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:22:34 INFO - 'PWD': '/builds/slave/test-pgo', 11:22:34 INFO - 'SHELL': '/bin/bash', 11:22:34 INFO - 'SHLVL': '1', 11:22:34 INFO - 'TERM': 'linux', 11:22:34 INFO - 'TMOUT': '86400', 11:22:34 INFO - 'USER': 'cltbld', 11:22:34 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1453749719.569958-536710323', 11:22:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:34 INFO - '_': '/tools/buildbot/bin/python'} 11:22:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:34 INFO - Downloading/unpacking jsonschema 11:22:34 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:34 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 - 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:34 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:34 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:34 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:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:22:36 INFO - Downloading/unpacking functools32 (from jsonschema) 11:22:36 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:36 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:36 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:36 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:36 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:36 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:36 INFO - Downloading functools32-3.2.3-2.tar.gz 11:22:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 11:22:36 INFO - warning: no files found matching '*.txt' 11:22:36 INFO - no previously-included directories found matching 'build' 11:22:36 INFO - no previously-included directories found matching 'dist' 11:22:36 INFO - no previously-included directories found matching '.git*' 11:22:36 INFO - Installing collected packages: jsonschema, functools32 11:22:36 INFO - Running setup.py install for functools32 11:22:36 INFO - warning: no files found matching '*.txt' 11:22:36 INFO - no previously-included directories found matching 'build' 11:22:36 INFO - no previously-included directories found matching 'dist' 11:22:36 INFO - no previously-included directories found matching '.git*' 11:22:36 INFO - Successfully installed jsonschema functools32 11:22:36 INFO - Cleaning up... 11:22:36 INFO - Return code: 0 11:22:36 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 11:22:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:36 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 0x7f8e3537ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2987450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a19a50>, '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 0x2985550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29859e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1453749719.569958-536710323', '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:36 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:36 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:36 INFO - Using env: {'DISPLAY': ':0', 11:22:36 INFO - 'HOME': '/home/cltbld', 11:22:36 INFO - 'LANG': 'en_US.UTF-8', 11:22:36 INFO - 'LANGUAGE': 'en_US:en', 11:22:36 INFO - 'LOGNAME': 'cltbld', 11:22:36 INFO - 'MAIL': '/var/mail/cltbld', 11:22:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:36 INFO - 'MOZ_NO_REMOTE': '1', 11:22:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:36 INFO - 'NO_EM_RESTART': '1', 11:22:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:22:36 INFO - 'PWD': '/builds/slave/test-pgo', 11:22:36 INFO - 'SHELL': '/bin/bash', 11:22:36 INFO - 'SHLVL': '1', 11:22:36 INFO - 'TERM': 'linux', 11:22:36 INFO - 'TMOUT': '86400', 11:22:36 INFO - 'USER': 'cltbld', 11:22:36 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1453749719.569958-536710323', 11:22:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:36 INFO - '_': '/tools/buildbot/bin/python'} 11:22:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:36 INFO - Downloading/unpacking flake8 11:22:36 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:36 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:36 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:36 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:36 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:36 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:38 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:22:38 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:22:38 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:38 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:38 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:38 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:38 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:38 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:38 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:22:38 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:22:38 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:38 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:38 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:38 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:38 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:38 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:38 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:22:38 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:38 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:38 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:38 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:38 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:38 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 - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 11:22:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:22:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:22:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:22:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:22:39 INFO - no previously-included directories found matching 'docs/_build' 11:22:39 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:22:39 INFO - Running setup.py install for pep8 11:22:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:22:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:22:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:22:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:22:39 INFO - no previously-included directories found matching 'docs/_build' 11:22:39 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 11:22:39 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:22:39 INFO - Cleaning up... 11:22:39 INFO - Return code: 0 11:22:39 INFO - Running post-action listener: _resource_record_post_action 11:22:39 INFO - Running post-action listener: _start_resource_monitoring 11:22:39 INFO - Starting resource monitoring. 11:22:39 INFO - ##### 11:22:39 INFO - ##### Running install step. 11:22:39 INFO - ##### 11:22:39 INFO - Running pre-action listener: _resource_record_pre_action 11:22:39 INFO - Running main action method: install 11:22:39 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:22:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:22:39 INFO - Reading from file tmpfile_stdout 11:22:39 INFO - Detecting whether we're running mozinstall >=1.0... 11:22:39 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 11:22:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 11:22:39 INFO - Reading from file tmpfile_stdout 11:22:39 INFO - Output received: 11:22:39 INFO - Usage: mozinstall [options] installer 11:22:39 INFO - Options: 11:22:39 INFO - -h, --help show this help message and exit 11:22:39 INFO - -d DEST, --destination=DEST 11:22:39 INFO - Directory to install application into. [default: 11:22:39 INFO - "/builds/slave/test-pgo"] 11:22:39 INFO - --app=APP Application being installed. [default: firefox] 11:22:39 INFO - mkdir: /builds/slave/test-pgo/build/application 11:22:39 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:39 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:54 INFO - Reading from file tmpfile_stdout 11:22:54 INFO - Output received: 11:22:54 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 11:22:54 INFO - Running post-action listener: _resource_record_post_action 11:22:54 INFO - ##### 11:22:54 INFO - ##### Running run-tests step. 11:22:54 INFO - ##### 11:22:54 INFO - Running pre-action listener: _resource_record_pre_action 11:22:54 INFO - Running main action method: run_tests 11:22:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 11:22:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 11:22:54 INFO - Python 2.7.3 11:22:54 INFO - Return code: 0 11:22:54 INFO - grabbing minidump binary from tooltool 11:22:54 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:54 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 0x2a19a50>, '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 0x2985550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29859e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 11:22:54 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:54 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:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:22:54 INFO - Return code: 0 11:22:54 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 11:22:54 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 11:22:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 11:22:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 11:22:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 11:22:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 11:22:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 11:22:55 INFO - Return code: 0 11:22:55 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-057', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 11:22:55 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-057 --webServer localhost 11:22:55 INFO - Using env: {'DISPLAY': ':0', 11:22:55 INFO - 'HOME': '/home/cltbld', 11:22:55 INFO - 'LANG': 'en_US.UTF-8', 11:22:55 INFO - 'LANGUAGE': 'en_US:en', 11:22:55 INFO - 'LOGNAME': 'cltbld', 11:22:55 INFO - 'MAIL': '/var/mail/cltbld', 11:22:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:22:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 11:22:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:55 INFO - 'MOZ_NO_REMOTE': '1', 11:22:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:22:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:55 INFO - 'NO_EM_RESTART': '1', 11:22:55 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:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:22:55 INFO - 'PWD': '/builds/slave/test-pgo', 11:22:55 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 11:22:55 INFO - 'SHELL': '/bin/bash', 11:22:55 INFO - 'SHLVL': '1', 11:22:55 INFO - 'TERM': 'linux', 11:22:55 INFO - 'TMOUT': '86400', 11:22:55 INFO - 'USER': 'cltbld', 11:22:55 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1453749719.569958-536710323', 11:22:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:55 INFO - '_': '/tools/buildbot/bin/python'} 11:22:55 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-057', '--webServer', 'localhost'] with output_timeout 3600 11:22:55 INFO - mozversion INFO | application_buildid: 20160125032407 11:22:55 INFO - mozversion INFO | application_changeset: 3bfa5bc61b626761d487b45c170b115259f69d6b 11:22:55 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 11:22:55 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:22:55 INFO - mozversion INFO | application_name: Firefox 11:22:55 INFO - mozversion INFO | application_remotingname: firefox-dev 11:22:55 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:22:55 INFO - mozversion INFO | application_vendor: Mozilla 11:22:55 INFO - mozversion INFO | application_version: 45.0a2 11:22:55 INFO - mozversion INFO | platform_buildid: 20160125032407 11:22:55 INFO - mozversion INFO | platform_changeset: 3bfa5bc61b626761d487b45c170b115259f69d6b 11:22:55 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:22:55 INFO - mozversion INFO | platform_version: 45.0a2 11:22:55 INFO - 2016-01-25 11:22:55,719 DEBUG : using testdate: 1453749775 11:22:55 INFO - 2016-01-25 11:22:55,719 DEBUG : actual date: 1453749775 11:22:55 INFO - 2016-01-25 11:22:55,766 INFO : starting webserver on 'localhost:48055' 11:22:55 INFO - 2016-01-25 11:22:55,767 INFO : Starting test suite talos-linux64-ix-057.e 11:22:55 INFO - 2016-01-25 11:22:55,767 INFO : Starting test dromaeo_css 11:22:55 INFO - 2016-01-25 11:22:55,768 DEBUG : operating with platform_type : linux_ 11:22:55 INFO - 2016-01-25 11:22:55,768 INFO : Initialising browser for dromaeo_css test... 11:22:55 INFO - 2016-01-25 11:22:55,785 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDL30is/profile http://localhost:48055/getInfo.html 11:22:59 INFO - 2016-01-25 11:22:59,586 DEBUG : BROWSER_OUTPUT: 11:22:59 INFO - 2016-01-25 11:22:59,587 DEBUG : BROWSER_OUTPUT: (process:5528): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:23:00 INFO - 2016-01-25 11:23:00,502 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:23:00 INFO - 2016-01-25 11:23:00,502 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:23:00 INFO - 2016-01-25 11:23:00,503 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:23:00 INFO - 2016-01-25 11:23:00,503 DEBUG : BROWSER_OUTPUT: __metrics 11:23:01 INFO - 2016-01-25 11:23:01,489 INFO : Browser initialized. 11:23:01 INFO - 2016-01-25 11:23:01,490 INFO : Running cycle 1/1 for dromaeo_css test... 11:23:01 INFO - 2016-01-25 11:23:01,490 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDL30is/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:23:02 INFO - 2016-01-25 11:23:02,807 DEBUG : BROWSER_OUTPUT: 11:23:02 INFO - 2016-01-25 11:23:02,807 DEBUG : BROWSER_OUTPUT: (process:5642): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:23:13 INFO - 2016-01-25 11:23:13,310 DEBUG : BROWSER_OUTPUT: RSS: Main: 136171520 11:23:13 INFO - 2016-01-25 11:23:13,311 DEBUG : BROWSER_OUTPUT: 11:24:02 INFO - 2016-01-25 11:24:02,919 DEBUG : BROWSER_OUTPUT: 1453749842915 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:10 INFO - 2016-01-25 11:26:10,780 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48055/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48055/tests/dromaeo/cssquery-ext.html) 11:26:11 INFO - 2016-01-25 11:26:11,871 DEBUG : BROWSER_OUTPUT: RSS: Main: 141283328 11:26:11 INFO - 2016-01-25 11:26:11,871 DEBUG : BROWSER_OUTPUT: 11:29:13 INFO - 2016-01-25 11:29:13,671 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48055/tests/dromaeo/cssquery-ext.html (next: http://localhost:48055/tests/dromaeo/cssquery-jquery.html) 11:29:14 INFO - 2016-01-25 11:29:14,253 DEBUG : BROWSER_OUTPUT: RSS: Main: 139657216 11:29:14 INFO - 2016-01-25 11:29:14,253 DEBUG : BROWSER_OUTPUT: 11:32:15 INFO - 2016-01-25 11:32:15,778 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48055/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48055/tests/dromaeo/cssquery-mootools.html) 11:32:16 INFO - 2016-01-25 11:32:16,380 DEBUG : BROWSER_OUTPUT: RSS: Main: 138801152 11:32:16 INFO - 2016-01-25 11:32:16,380 DEBUG : BROWSER_OUTPUT: 11:35:17 INFO - 2016-01-25 11:35:17,981 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48055/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48055/tests/dromaeo/cssquery-prototype.html) 11:35:18 INFO - 2016-01-25 11:35:18,587 DEBUG : BROWSER_OUTPUT: RSS: Main: 139591680 11:35:18 INFO - 2016-01-25 11:35:18,588 DEBUG : BROWSER_OUTPUT: 11:38:20 INFO - 2016-01-25 11:38:20,810 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48055/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48055/tests/dromaeo/cssquery-yui.html) 11:38:21 INFO - 2016-01-25 11:38:21,432 DEBUG : BROWSER_OUTPUT: RSS: Main: 138768384 11:38:21 INFO - 2016-01-25 11:38:21,433 DEBUG : BROWSER_OUTPUT: 11:41:23 INFO - 2016-01-25 11:41:23,442 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48055/tests/dromaeo/cssquery-yui.html (next: http://localhost:48055/tests/dromaeo/cssquery-dojo.html) 11:41:23 INFO - 2016-01-25 11:41:23,686 DEBUG : BROWSER_OUTPUT: RSS: Main: 140816384 11:41:23 INFO - 2016-01-25 11:41:23,686 DEBUG : BROWSER_OUTPUT: 11:41:23 INFO - 2016-01-25 11:41:23,686 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:41:23 INFO - 2016-01-25 11:41:23,687 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:41:23 INFO - 2016-01-25 11:41:23,687 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:41:23 INFO - 2016-01-25 11:41:23,687 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:41:23 INFO - 2016-01-25 11:41:23,688 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3243.967560324397;3259.3970115528646;3288.1286459088346;3311.7516186286025;3318.5851768528933;5517.420670829565;5526.447355264477;5532.419095994923;5532.446755324466;5559.722013899309;5559.638623489471;5584.52531534819;5601.439856014396;5603.215549823028;5663.886722265553;5078.111330517163;5122.078025955327;5188.584913206953;5206.349206349207;5237.947620523803;4814.614830813544;5029.094762942669;5032.295478632995;5087.491250874901;5217.321748172732;4999.550040496355;5072.72100034498;5084.4661310562415;5087.898242035157;5209.635325527214;5145.76844042019;5158.664686795346;5161.458046905096;5177.870553236162;5189.273501709764;4882.170031094687;4966.87582810429;5012.097822391968;5083.61872859537;5094.566961808251;5260.736963151827;5372.892542149174;5389.5688344932705;5393.622446428752;5397.082495975655;5890.793822216202;5928.40715928408;5932.317783454915;5950.315713692938;5989.251343582052;5712.057510510761;5853.385394533555;5922.911156332659;5995.010823214165;6027.578069535134;5643.802466913679;5646.096624540095;5656.095024796013;5656.179853921159;5660.575456840712;6147.72335244915;6149.13912052313;6167.876642467215;6176.505879529627;6177.876442471125;5672.801451949244;5747;5749.8275051748515;5872.324682661463;5890.528757699374;5839.299284085937;5929.73316200772;5953.434423729739;5987.2815262168815;6007.249093863267;5788.102844059177;5862.94137058624;5886.23478947734;5891.764329426861;5933.9406605934255;5757.568182386338;5847;5855.151003104611;5863.70681465925;5874.647521148745;4537.4328208973875;4551.3173024046;4564.7717614119165;4575.908481830411;4577.450705915311;3978.5822488638278;4052.473178486837;4080.1431699342875;4105.384192371109;4128.298189307825;5528.668279903219;5583.581231407579;5589.329280486368;5614.719264036782;5643.068893632505;5988.550858685616;6030.095485677183;6037.396260374016;6046.3651316612;6046.909296360558;5478.835634930959;5564.721763911869;5689.687067211343;5735.1970724098655;5748.597598168171;5094.235864620263;5096.61775366849;5136.948630513722;5142.820001299937;5185.533302002762;5976.850578735566;5998.940010599926;6004.099385092271;6009.248843894513;6017.247844019497;5765.538756899522;5888.028475301699;5929.466348028698;5990.1913241713555;6110.480609148272;6138;6141.508679305734;6142.3550527194;6143.293521244936;6143.32423433413;5862.530997520274;5923.674197919156;5945.821625351246;5949.077892926603;5958.612690175125;5714.714264286686;5866.560007999503;5921.822345329647;6014.699265036818;6057.878842423215;5860.062390017577;5917.881642367042;5918.023526118314;5919.378465261086;5920.615160014585;5655.745491452977;5904.793332233351;5904.940950590439;5907.291125064848;5922.052471604523;5606.579506536945;5641.858953526031;5686.033374326292;5711.714414279187;5717.42825717425;5812.21535092757;5814.156947242711;5818.040023396262;5846.976779063732;5855.531557475307;5615.5507559395965;5648.378678345461;5719.084946408555;5735.254416925773;5744.368119506935 11:41:23 INFO - 2016-01-25 11:41:23,689 DEBUG : BROWSER_OUTPUT: |1;ext.html;588.7968650815467;625.3808729357937;626.1484381241511;628.7987843889956;630.1618846933579;43179;43562.782186089105;44095.999999999956;44124.11751764967;44196.55803441965;45824.083518329615;46442.303365449545;46488.53511464885;46507;46556.301655475196;8964.238039766627;9073.09269073094;9162;9165.266778657724;9191.586378612945;8806.163414475646;8898.86651700225;8946.910530894673;8956.641734330651;8990.37067405282;9017.053209412983;9094.226990705798;9103.180713735763;9114.27085833135;9117.95441022794;8929.910700892973;8945.418547794372;8995;9030.367874248805;9030.638774449048;8797;9057.275417966546;9076.546172691405;9082.545872706338;9097.954510227406;43273.35089973653;43683.78158109221;44052.77973610144;44151.33772993408;44217.11565768699;3544.1848374873666;3636.8727094551564;3832.8466861325514;4196.475440569929;4317.136572685476;33611.831940840384;33719.494207586664;33748.49377259343;33760.32479350399;34992.125196870285;3684.7420680552373;3730.011546940063;3732.533433320835;3736.794476303802;3880.3597406427907;281283;285009;285219;286232;286952;64751.352486474534;65092.34907650958;65181.67409162924;65207;65366.34633653603;68374;68516.6574167126;68534.65732671304;68669;68711.65644171747;16048.438304659281;16307.1031093291;16489.752653710202;16518.2566784495;16599;13379.397927093305;13403.195808251536;13457.596272111656;13517.864821351857;13523.797143042862;21812.563748724937;21875.234366797085;22126.668099978513;22136.778632213794;22224.222152224916;7805.882911756328;8037.196280371916;8055;8098.473599216032;8118.918810811934;1054.2620165883911;1089.983650245247;1116.3469370418234;1138.3966497756203;1213.9939300303618;29811;29957.251068723457;30230.54654180189;30382.84808575943;30689.386212276077;1040.360178490223;1062.1927335225284;1063.984040239397;1080.7892460970036;1108.0913650806262;14251.786223206453;14302.928485357506;14380.137191768526;14584.270786460635;14650.340734666752;347585;355507;358041;361254;506327;48625.27062094071;48977.26534101991;49003.26495102576;49017.75491122593;49081.75459122682;1472.5803146103524;1478.4529724002189;1487.5016869348674;1490.8136482939633;1602.671452352265;28760.71239287664;29941.70058299389;30104.548431773102;30283.242918927204;30333.393332133674;48169.27746083742;48257.5174248253;48282.275765864244;48316.27525587049;48388.51611483981;265932;266280;267241;267898;268607;33195;33263.66736332606;33622;36116.63883361133;36157.27685446329;43857;44015.339769904116;44175;44437.333439997776;45368.546314536434;38249.80875095718;38266.23467530578;38338;38611.420828688155;38894.80552597219;38819;40733.79633101934;40958.5664501741;40971.79514102411;41540.1691966165;35651.46522802108;35688.643113568534;35946;36023.819880900424;38341.80829095837;31835.840820795747;33079;33773.662263378035;34215.31569368648;34573.30853382969;25695.614565781903;25951;26161.345966350993;26371.736282637696;26454.735452645997 11:41:23 INFO - 2016-01-25 11:41:23,691 DEBUG : BROWSER_OUTPUT: |2;jquery.html;386.7872670031482;388.5298788465956;389.08370786797093;393.07234925575636;394.9131191137949;17971.64056718865;18209.453716388514;18734.250629974784;20105.296314628973;20160.495987600298;16849.07330096844;16887.071211083385;16904.492865214033;16927.407540736076;17055.317787288524;5006.123928312549;5125.564327032207;5131.255967884655;5134.460881607433;5149.382074151107;5103.209002604603;5283.63014588979;5486.972565137169;5515.117581187011;5515.365732940723;5459.208414779854;5467;5480.506754392104;5502.119660854264;5699.2306038684865;5576.609637325369;5607.186957891083;5627.915581266284;5633.211350410946;5643.830685079454;5170.224466330043;5429.67421954684;5432.565394768409;5525.778968841241;5597.076482380402;13529.864701353057;13749.31253437334;13788.93105534466;13832.861671383258;14314;2184.8907554622206;2224.1881713174735;2247.2471721973156;2271.8750468724215;2297.5634629420356;10404.063634272952;10407.479626018745;10534.473276336152;10559.313644613076;10672.359658420519;1919.6928491441442;1919.7120431935182;1961.8234358907766;1978.9808248751904;1987.7117817916321;63352.68323658398;64692.67653661749;65536.6723166386;66299;66784.33215667878;10743.785124297627;10905.18211134168;10920.617778377877;10976.067034302014;10978.341299522055;14200.573982780534;14268.57194284173;14320.785188222186;14350.282485875665;14382.208978506073;7995.440319177718;8032.196780321921;8212.219839115274;8231.711890083818;8248.752537423887;7901.644426000844;7939.245771651684;7941.166177551274;7964.402669799788;8021.2379823916635;4651.418572678415;4674.509176536482;4737;4781.95218047822;4856.465788763233;1956.3544030469911;1970.0740651893586;2033.196887229536;2039.9184032638825;2063.1953538120147;491.8008206676302;495.0519754669839;509.571959553969;930.6463543853292;1126.1272513801869;11740.647780566596;11864.347460889734;11899.34553599543;11981.46083426248;12010.75978480443;485.8712441203084;492.7979528393413;494.675987228366;510.02585062530386;520.47432093585;6007.879842403127;6429.839254018687;6508.544401891822;6523.673816309166;6548.639824809681;635994;642901;643372;646228;646817;86564;87264.56367718121;87751.56124219338;88585;88965.55517222373;527.7888844462245;530.7744208711282;531.0865311663932;531.418097183591;532.1379365428031;10878.075363593867;10987;11093.445327733742;11141.83287250708;11237.887621123684;35204.823975879954;35461;36047.098822529646;36095;36644.63355366519;49608.50391496039;49704.75147624239;50025.24962125644;51317.486825132764;51567;10131.7467063324;10175.084242418217;10399.844002340122;10458.895411045793;10591.788164236517;17895.19471623754;18334.174962127003;18435.354762583243;18576.628467430844;18769.90615046916;15011.174385408907;15055.698886021999;15170;15708.371665133267;15839.445619403266;14983;15324.310406031978;15400.922995384952;15494.612634684223;15654.530364089096;15016.399344026117;15031.248437578297;15210.46763363277;15501;15524.767128492857;10278.537465814206;10382.478195098376;10399.688009359732;10527.368357898551;10532.684019479122;11222.541069660892;11269.04213141892;14102.78845817293;15798.289076991334;15891.523254302389 11:41:23 INFO - 2016-01-25 11:41:23,692 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1519.460591490021;1523.7485814840552;1768.3899054826081;1829.204296131183;1860.5999710062333;7708.691652333907;7858;7859.76420707379;7885.053793544768;7990.320822730075;8046.235607617282;8086.110527841947;8110;8154.673813047486;8159.388045896551;2082.4481512399225;2086.8330533557278;2087.2381580723004;2099.88450635215;2143.099898042818;2225.310153852303;2257.9209727659536;2266.4900397410534;2278.6582012698145;2280.2133264023887;2131.7548481924623;2168;2173.4131784418196;2287.0965968442456;2304.3547806614174;2291.3813270416895;2312.976870231293;2338.543983923136;2340.2511196417154;2347.1902193743217;2270.829687773407;2327.418145463634;2332.755060718617;2334.26470661741;2334.953300933989;7792.571408572526;7852.489588176807;7870.409719271021;7881.684732610746;7905.249001344863;4554.544545545452;4616.838410655611;4622.468416132154;4628.305754136873;4635.188841952645;2964.8962286319875;2976.1369202931123;3034.757219422463;3040.011996101276;3046.7410270127066;989.6931951095112;992.3103443107043;999.0858364596386;1011.3274672342883;1030.319988807391;10454.477276136162;10466.68599942003;10503.317284376491;10529.36823790575;10546.209034322457;4035.5157381114454;4051.8784436466954;4069.1658210066867;4097.385392191195;4188.8115034822895;8717.389782715149;8717.607707653171;8722.215000649972;8736.519491427905;8754.343424243207;4596.701214421052;4623.537646235417;4637.234856248681;4652.720836749806;4662.7202367858035;4281.850135245251;4303.849365272201;4316.179925814148;4330.41539392178;4343.066240758252;3478.426059700121;3487.2502411981545;3503;3526.753127281117;3529.3647143514413;1043.3062013760916;1050.7635781949;1054.981942425563;1058.3755584205355;1064.414571985405;1088.711491454765;1095.7479779650726;1163.33689796815;1335.3123141582093;1416.9716605668036;7354.114330167122;7372;7385.261473852679;7418.777436676908;7439.590822504706;1149.9195056345975;1153.8326942593444;1155.856071485558;1175.2948231061296;1179.3582375478866;6000.579959402888;6065.120557519135;6083.908741368883;6092.208012958287;6094.8171554853425;8550.700725474579;8852.114788521225;8920.24177944882;8930.240929521064;8951.239144672645;8794.86807697885;8812.427192232484;8879.822403551892;8886.777830554158;8889.155530224618;7279.526830755984;7306.452016098814;7364.042674452394;7367.63161841895;7406;7186.46101542376;7213.2065472799;7237.819054523679;7261.5280006799385;7318.194998550049;8225.753227403187;8232;8352.83294334122;8452.830943380975;8496.53269070207;8514.91485085166;8523.616437260214;8585.82828343442;8636.784080397789;8678.479291242546;6931.2375638678695;7218.133823941161;7238.6380680966795;7242.420606351585;7249.456290778107;7526;7562.659680314289;7598.8100297493;7605.961970190114;7642.197569255148;6267.811965641038;6803.863922721617;6847.161572052401;7009.369156775914;7267.890981635174;6555.6066636002;6635.63504007265;7054.682539285642;7080.114985626797;7244.673989670372;7301.342879140902;7307.744228951961;7307.963460182665;7386.2613738625705;7389.408847292311;6497.707603157774;6512.967435162794;6556.606603603799;6591.769288074895;6598.472122230114;6809.38715515606;6875.828104297232;6883.896741548981;6934.791956241321;6935.653217339213 11:41:23 INFO - 2016-01-25 11:41:23,694 DEBUG : BROWSER_OUTPUT: |4;prototype.html;344.12763644162044;352.6332614081355;355.54490252476836;355.59284619111116;357.5834153211509;6226.159468471755;6294.0558916162545;6298;6369.777057802978;6466.902996455057;6242.126102345664;6323.6521991290465;6331;6334.271558770743;6344.111824344595;4799.952000480003;4801.927971080419;4803.711777293365;4810.97594512027;4822.180229361017;4792.664513484057;4798.256270278112;4801.591864691488;4811.398575178103;4816.54242846929;4694.694844835092;4722.858314250578;4745.359376484183;4768.094062128202;4772.880677983061;4704.45898721648;4741.644376671747;4751.216049351853;4759.643026772988;4767.737774422405;4124.237016152021;4129.401236820644;4138.296489596776;4139.441175441337;4141.627253547165;5971;5997.4002599740115;6015.518758499309;6024.939750602482;6033.245844269466;5411.83764487066;5453.318335208099;5504.394516603171;5505.311836020497;5521.889562208774;6641.302663220389;6642.136522252124;6644;6644.368784965421;6648.335166483313;4544.545545445462;4545.477270113913;4548.363229147922;4550.817967281305;4550.977245113753;6827.249002609709;6915.308469153095;6978.790636280869;6980.546264492842;7000.474964377641;4731.124741922756;4757.5718185363485;4757.95242047582;4758.405199350082;4759.214729569582;4808.831690890872;4820.373351464287;4823.493533179036;4827.662063655511;4830.9371938173545;5525.613207075467;5529.585281103933;5532.2531458253425;5536.335639723259;5536.695481748462;6526.575772574767;6615.4046135848;6658.5671931324305;6667.266600673922;6667.49993750461;1661.4434164554768;1681.2770508681385;1699.9490015299561;1701.3194722111007;1703.3101593854508;1141.9828702569469;1165.3066425476827;1165.5862168930078;1168.5033860609208;1178.5698220149754;6423.13287706163;6449.806505804833;6449.96775016122;6451;6477.4494167996245;6838.7264509419065;6860.931390686029;6873.690683919235;6875.3124687531845;6898.344657257552;6350.396712312323;6387.425131738166;6416.165898433267;6420.390062944013;6428.260750013715;3718.8698395556567;3719.2189640175866;3721.6650501455;3734.3278209922473;3747.4004159334377;6920.238773734885;6943.89584156238;6959.338862808025;7008.474364422688;7035.401990830735;6828.351306625863;6922.307769223037;6929.653517324114;6933.826654333682;6963.234044255128;6980.336867997532;6998.125234345707;7007.194172670208;7014.92985070153;7016.5088443808445;6790.25307216196;6839.863202735818;6862.4853136016;6863.794086177422;6864.691088900911;6650.570127422628;6698.162729658793;6698.631575263407;6736.5958042517605;6812.65936703153;7139.286071392819;7139.643017849191;7189.784306470814;7197.71209151628;7212.675429605575;4636.072785442992;4645.5354464553275;4697;4700.177468942989;4712.717236965793;6887.035814985806;7013.929860701328;7018.2630823762765;7050.083489146378;7064.399526040139;6798.660066996729;6834.897476537955;6842.623655698984;6853.7943861684225;6865.553739007149;6806.489513286424;6815.488838337045;6826.795196144124;6828.385445309946;6834;6594.439472644879;6679.799606011828;6684.966575167093;6691.966540167268;6707.128073350434;6696.229933557704;6752.459803215633;6758.357955994173;6782.694778735067;6808.455323574003;6664.766733164316;6675.365840245169;6675.9666201670625;6682.899756503559;6688.431483323972 11:41:23 INFO - 2016-01-25 11:41:23,695 DEBUG : BROWSER_OUTPUT: |5;yui.html;862.2584577263552;954.0864547579966;957.0525180071727;958.9328746987709;968.0996673094022;14672.19302938338;14884.25578721065;14888.032277901943;14932.626684332898;15002.774958375632;14323.85676143241;14448.349824257908;14471.638209044779;14475.638109047279;14493.855061449382;911.5943405184695;927.7355953553239;930.3394589841187;935.3966691483989;949.5679465843025;914.4833169259347;915.327234482658;924.0482303227652;924.3021518753332;924.574695640003;953.9952300238489;954.0173621170205;955.5795450001976;961.5096300886563;963.8602402651611;946.1815529566875;951.3483263964172;956.5743244256308;958.4824194934727;958.8657587937695;703.3810246982623;705.587231469591;707.8195060259652;709.163187438822;712.5083692252381;15054.172020538866;15174.468893588672;15220.543383698507;15230.695386092328;15237.390504379922;12051.369110627365;12265.938670306681;12322.630321090382;12365.38173091342;12712.809307860389;11388.487518061707;11636;12030.578929737418;12045.939770301093;12118.601265634787;3865.439511270878;3954.2882281189372;3965.167314863882;3973.165635216608;4053.6959728020515;52166.7391663043;52543.73728131373;52842.73578632121;53125.73437132828;53218.46781532174;9906.356086854332;10025.147862431775;10130.797384052277;10551.894481055244;10940.507677154546;19226;19382.8061719381;19463.610727785366;19505.219791208478;19508.609827803364;7586.772396828104;7751.224877512203;7895.526268423913;8000.079990801016;8014.398920081017;4000.759384898242;4023.275810354164;4105.220008198433;4122.154958233615;4140.751554906716;3268.0686004488607;3323.5513205717402;3330.750193735431;3342.4317865962844;3349.564556607674;603.7102190948369;607.5018484842387;608.4736702752087;608.9482393996472;620.965846878417;660.7125900233414;677.6882633988322;734.8236423258379;743.8809790433505;757.1179575794138;9258.861117083248;9428.95285523568;9441.811163776685;9518.238540916711;9639.421634701941;689.3864460630043;695.7286658203304;706.9893951590731;739.9260073992558;749.3405802893419;4201.7268877522865;4454.732716037048;4557.863264102082;4562.087582483517;4602.884927876763;53150.493318346445;54207;54598.18102728383;54609.180862287096;54704.45295546993;54395.45604543904;55183.72408137934;55567.44432555704;56030;56135.43864561384;48838;49505.50494495081;50037.24944125841;50062.749686251336;50368.49631503711;8486.405951583576;8598.39811213209;8684.161032636293;8870.778230544289;8958.641654334015;36378.45432318465;36510.63489365178;36999;37209.069773255884;37627.623723762415;42476.78761606172;42886.57113428951;46296;48044.759776200895;49052.26421603608;10697.3046751964;11892.46483908209;12091;12346.13577049598;12467.563635272722;13134.211947283193;13144.34278286101;13318.667033324244;13738.587842364745;13836.377363018488;12580;12752.808707869575;12828.679283017998;12967.22196668203;12994.675133121747;11640.592579260025;11912.225705329125;12030.63908082759;12090.51637934508;12365.690857728629;11367.090632749525;11420.172772356384;12062.698432539257;12755.002962690038;12849.229046257255;10597.682069537927;10840.241183117107;10964.725881853017;11107.777844443228;11127.1654625905;10493.685189444328;11082.224244303145;11137.164712646421;11170.664880053611;11239.325640461599 11:41:23 INFO - 2016-01-25 11:41:23,695 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:41:23 INFO - 2016-01-25 11:41:23,695 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:41:23 INFO - 2016-01-25 11:41:23,695 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,309 11:41:23 INFO - 2016-01-25 11:41:23,695 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:41:23 INFO - 2016-01-25 11:41:23,695 DEBUG : BROWSER_OUTPUT: __startTimestamp1453750883686__endTimestamp 11:41:23 INFO - 2016-01-25 11:41:23,696 DEBUG : BROWSER_OUTPUT: 11:41:23 INFO - 2016-01-25 11:41:23,696 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:41:23 INFO - 2016-01-25 11:41:23,696 DEBUG : BROWSER_OUTPUT: Number of tests: 6 11:41:23 INFO - 2016-01-25 11:41:23,696 DEBUG : BROWSER_OUTPUT: 11:41:23 INFO - 2016-01-25 11:41:23,696 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5523.05 Median:5714.71 stddev:612.36 (10.7%) stddev-sans-first:587.56 11:41:23 INFO - 2016-01-25 11:41:23,696 DEBUG : BROWSER_OUTPUT: Values: 3244.0 3259.4 3288.1 3311.8 3318.6 5517.4 5526.4 5532.4 5532.4 5559.7 5559.6 5584.5 5601.4 5603.2 5663.9 5078.1 5122.1 5188.6 5206.3 5237.9 4814.6 5029.1 5032.3 5087.5 5217.3 4999.6 5072.7 5084.5 5087.9 5209.6 5145.8 5158.7 5161.5 5177.9 5189.3 4882.2 4966.9 5012.1 5083.6 5094.6 5260.7 5372.9 5389.6 5393.6 5397.1 5890.8 5928.4 5932.3 5950.3 5989.3 5712.1 5853.4 5922.9 5995.0 6027.6 5643.8 5646.1 5656.1 5656.2 5660.6 6147.7 6149.1 6167.9 6176.5 6177.9 5672.8 5747.0 5749.8 5872.3 5890.5 5839.3 5929.7 5953.4 5987.3 6007.2 5788.1 5862.9 5886.2 5891.8 5933.9 5757.6 5847.0 5855.2 5863.7 5874.6 4537.4 4551.3 4564.8 4575.9 4577.5 3978.6 4052.5 4080.1 4105.4 4128.3 5528.7 5583.6 5589.3 5614.7 5643.1 5988.6 6030.1 6037.4 6046.4 6046.9 5478.8 5564.7 5689.7 5735.2 5748.6 5094.2 5096.6 5136.9 5142.8 5185.5 5976.9 5998.9 6004.1 6009.2 6017.2 5765.5 5888.0 5929.5 5990.2 6110.5 6138.0 6141.5 6142.4 6143.3 6143.3 5862.5 5923.7 5945.8 5949.1 5958.6 5714.7 5866.6 5921.8 6014.7 6057.9 5860.1 5917.9 5918.0 5919.4 5920.6 5655.7 5904.8 5904.9 5907.3 5922.1 5606.6 5641.9 5686.0 5711.7 5717.4 5812.2 5814.2 5818.0 5847.0 5855.5 5615.6 5648.4 5719.1 5735.3 5744.4 11:41:23 INFO - 2016-01-25 11:41:23,696 DEBUG : BROWSER_OUTPUT: 11:41:23 INFO - 2016-01-25 11:41:23,696 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:49506.49 Median:21049.54 stddev:83648.84 (397.4%) stddev-sans-first:83802.86 11:41:23 INFO - 2016-01-25 11:41:23,698 DEBUG : BROWSER_OUTPUT: Values: 588.8 625.4 626.1 628.8 630.2 43179.0 43562.8 44096.0 44124.1 44196.6 45824.1 46442.3 46488.5 46507.0 46556.3 8964.2 9073.1 9162.0 9165.3 9191.6 8806.2 8898.9 8946.9 8956.6 8990.4 9017.1 9094.2 9103.2 9114.3 9118.0 8929.9 8945.4 8995.0 9030.4 9030.6 8797.0 9057.3 9076.5 9082.5 9098.0 43273.4 43683.8 44052.8 44151.3 44217.1 3544.2 3636.9 3832.8 4196.5 4317.1 33611.8 33719.5 33748.5 33760.3 34992.1 3684.7 3730.0 3732.5 3736.8 3880.4 281283.0 285009.0 285219.0 286232.0 286952.0 64751.4 65092.3 65181.7 65207.0 65366.3 68374.0 68516.7 68534.7 68669.0 68711.7 16048.4 16307.1 16489.8 16518.3 16599.0 13379.4 13403.2 13457.6 13517.9 13523.8 21812.6 21875.2 22126.7 22136.8 22224.2 7805.9 8037.2 8055.0 8098.5 8118.9 1054.3 1090.0 1116.3 1138.4 1214.0 29811.0 29957.3 30230.5 30382.8 30689.4 1040.4 1062.2 1064.0 1080.8 1108.1 14251.8 14302.9 14380.1 14584.3 14650.3 347585.0 355507.0 358041.0 361254.0 506327.0 48625.3 48977.3 49003.3 49017.8 49081.8 1472.6 1478.5 1487.5 1490.8 1602.7 28760.7 29941.7 30104.5 30283.2 30333.4 48169.3 48257.5 48282.3 48316.3 48388.5 265932.0 266280.0 267241.0 267898.0 268607.0 33195.0 33263.7 33622.0 36116.6 36157.3 43857.0 44015.3 44175.0 44437.3 45368.5 38249.8 38266.2 38338.0 38611.4 38894.8 38819.0 40733.8 40958.6 40971.8 41540.2 35651.5 35688.6 35946.0 36023.8 38341.8 31835.8 33079.0 33773.7 34215.3 34573.3 25695.6 25951.0 26161.3 26371.7 26454.7 11:41:23 INFO - 2016-01-25 11:41:23,698 DEBUG : BROWSER_OUTPUT: 11:41:23 INFO - 2016-01-25 11:41:23,698 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:32014.40 Median:18751.19 stddev:105148.05 (560.8%) stddev-sans-first:105416.19 11:41:23 INFO - 2016-01-25 11:41:23,698 DEBUG : BROWSER_OUTPUT: Values: 386.8 388.5 389.1 393.1 394.9 17971.6 18209.5 18734.3 20105.3 20160.5 16849.1 16887.1 16904.5 16927.4 17055.3 5006.1 5125.6 5131.3 5134.5 5149.4 5103.2 5283.6 5487.0 5515.1 5515.4 5459.2 5467.0 5480.5 5502.1 5699.2 5576.6 5607.2 5627.9 5633.2 5643.8 5170.2 5429.7 5432.6 5525.8 5597.1 13529.9 13749.3 13788.9 13832.9 14314.0 2184.9 2224.2 2247.2 2271.9 2297.6 10404.1 10407.5 10534.5 10559.3 10672.4 1919.7 1919.7 1961.8 1979.0 1987.7 63352.7 64692.7 65536.7 66299.0 66784.3 10743.8 10905.2 10920.6 10976.1 10978.3 14200.6 14268.6 14320.8 14350.3 14382.2 7995.4 8032.2 8212.2 8231.7 8248.8 7901.6 7939.2 7941.2 7964.4 8021.2 4651.4 4674.5 4737.0 4782.0 4856.5 1956.4 1970.1 2033.2 2039.9 2063.2 491.8 495.1 509.6 930.6 1126.1 11740.6 11864.3 11899.3 11981.5 12010.8 485.9 492.8 494.7 510.0 520.5 6007.9 6429.8 6508.5 6523.7 6548.6 635994.0 642901.0 643372.0 646228.0 646817.0 86564.0 87264.6 87751.6 88585.0 88965.6 527.8 530.8 531.1 531.4 532.1 10878.1 10987.0 11093.4 11141.8 11237.9 35204.8 35461.0 36047.1 36095.0 36644.6 49608.5 49704.8 50025.2 51317.5 51567.0 10131.7 10175.1 10399.8 10458.9 10591.8 17895.2 18334.2 18435.4 18576.6 18769.9 15011.2 15055.7 15170.0 15708.4 15839.4 14983.0 15324.3 15400.9 15494.6 15654.5 15016.4 15031.2 15210.5 15501.0 15524.8 10278.5 10382.5 10399.7 10527.4 10532.7 11222.5 11269.0 14102.8 15798.3 15891.5 11:41:23 INFO - 2016-01-25 11:41:23,698 DEBUG : BROWSER_OUTPUT: 11:41:23 INFO - 2016-01-25 11:41:23,698 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5460.25 Median:6556.11 stddev:2802.25 (42.7%) stddev-sans-first:2794.46 11:41:23 INFO - 2016-01-25 11:41:23,698 DEBUG : BROWSER_OUTPUT: Values: 1519.5 1523.7 1768.4 1829.2 1860.6 7708.7 7858.0 7859.8 7885.1 7990.3 8046.2 8086.1 8110.0 8154.7 8159.4 2082.4 2086.8 2087.2 2099.9 2143.1 2225.3 2257.9 2266.5 2278.7 2280.2 2131.8 2168.0 2173.4 2287.1 2304.4 2291.4 2313.0 2338.5 2340.3 2347.2 2270.8 2327.4 2332.8 2334.3 2335.0 7792.6 7852.5 7870.4 7881.7 7905.2 4554.5 4616.8 4622.5 4628.3 4635.2 2964.9 2976.1 3034.8 3040.0 3046.7 989.7 992.3 999.1 1011.3 1030.3 10454.5 10466.7 10503.3 10529.4 10546.2 4035.5 4051.9 4069.2 4097.4 4188.8 8717.4 8717.6 8722.2 8736.5 8754.3 4596.7 4623.5 4637.2 4652.7 4662.7 4281.9 4303.8 4316.2 4330.4 4343.1 3478.4 3487.3 3503.0 3526.8 3529.4 1043.3 1050.8 1055.0 1058.4 1064.4 1088.7 1095.7 1163.3 1335.3 1417.0 7354.1 7372.0 7385.3 7418.8 7439.6 1149.9 1153.8 1155.9 1175.3 1179.4 6000.6 6065.1 6083.9 6092.2 6094.8 8550.7 8852.1 8920.2 8930.2 8951.2 8794.9 8812.4 8879.8 8886.8 8889.2 7279.5 7306.5 7364.0 7367.6 7406.0 7186.5 7213.2 7237.8 7261.5 7318.2 8225.8 8232.0 8352.8 8452.8 8496.5 8514.9 8523.6 8585.8 8636.8 8678.5 6931.2 7218.1 7238.6 7242.4 7249.5 7526.0 7562.7 7598.8 7606.0 7642.2 6267.8 6803.9 6847.2 7009.4 7267.9 6555.6 6635.6 7054.7 7080.1 7244.7 7301.3 7307.7 7308.0 7386.3 7389.4 6497.7 6513.0 6556.6 6591.8 6598.5 6809.4 6875.8 6883.9 6934.8 6935.7 11:41:23 INFO - 2016-01-25 11:41:23,698 DEBUG : BROWSER_OUTPUT: 11:41:23 INFO - 2016-01-25 11:41:23,699 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5582.63 Median:6401.80 stddev:1686.86 (26.3%) stddev-sans-first:1645.13 11:41:23 INFO - 2016-01-25 11:41:23,699 DEBUG : BROWSER_OUTPUT: Values: 344.1 352.6 355.5 355.6 357.6 6226.2 6294.1 6298.0 6369.8 6466.9 6242.1 6323.7 6331.0 6334.3 6344.1 4800.0 4801.9 4803.7 4811.0 4822.2 4792.7 4798.3 4801.6 4811.4 4816.5 4694.7 4722.9 4745.4 4768.1 4772.9 4704.5 4741.6 4751.2 4759.6 4767.7 4124.2 4129.4 4138.3 4139.4 4141.6 5971.0 5997.4 6015.5 6024.9 6033.2 5411.8 5453.3 5504.4 5505.3 5521.9 6641.3 6642.1 6644.0 6644.4 6648.3 4544.5 4545.5 4548.4 4550.8 4551.0 6827.2 6915.3 6978.8 6980.5 7000.5 4731.1 4757.6 4758.0 4758.4 4759.2 4808.8 4820.4 4823.5 4827.7 4830.9 5525.6 5529.6 5532.3 5536.3 5536.7 6526.6 6615.4 6658.6 6667.3 6667.5 1661.4 1681.3 1699.9 1701.3 1703.3 1142.0 1165.3 1165.6 1168.5 1178.6 6423.1 6449.8 6450.0 6451.0 6477.4 6838.7 6860.9 6873.7 6875.3 6898.3 6350.4 6387.4 6416.2 6420.4 6428.3 3718.9 3719.2 3721.7 3734.3 3747.4 6920.2 6943.9 6959.3 7008.5 7035.4 6828.4 6922.3 6929.7 6933.8 6963.2 6980.3 6998.1 7007.2 7014.9 7016.5 6790.3 6839.9 6862.5 6863.8 6864.7 6650.6 6698.2 6698.6 6736.6 6812.7 7139.3 7139.6 7189.8 7197.7 7212.7 4636.1 4645.5 4697.0 4700.2 4712.7 6887.0 7013.9 7018.3 7050.1 7064.4 6798.7 6834.9 6842.6 6853.8 6865.6 6806.5 6815.5 6826.8 6828.4 6834.0 6594.4 6679.8 6685.0 6692.0 6707.1 6696.2 6752.5 6758.4 6782.7 6808.5 6664.8 6675.4 6676.0 6682.9 6688.4 11:41:23 INFO - 2016-01-25 11:41:23,699 DEBUG : BROWSER_OUTPUT: 11:41:23 INFO - 2016-01-25 11:41:23,700 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14636.10 Median:42681.68 stddev:16535.84 (38.7%) stddev-sans-first:16549.87 11:41:23 INFO - 2016-01-25 11:41:23,700 DEBUG : BROWSER_OUTPUT: Values: 862.3 954.1 957.1 958.9 968.1 14672.2 14884.3 14888.0 14932.6 15002.8 14323.9 14448.3 14471.6 14475.6 14493.9 911.6 927.7 930.3 935.4 949.6 914.5 915.3 924.0 924.3 924.6 954.0 954.0 955.6 961.5 963.9 946.2 951.3 956.6 958.5 958.9 703.4 705.6 707.8 709.2 712.5 15054.2 15174.5 15220.5 15230.7 15237.4 12051.4 12265.9 12322.6 12365.4 12712.8 11388.5 11636.0 12030.6 12045.9 12118.6 3865.4 3954.3 3965.2 3973.2 4053.7 52166.7 52543.7 52842.7 53125.7 53218.5 9906.4 10025.1 10130.8 10551.9 10940.5 19226.0 19382.8 19463.6 19505.2 19508.6 7586.8 7751.2 7895.5 8000.1 8014.4 4000.8 4023.3 4105.2 4122.2 4140.8 3268.1 3323.6 3330.8 3342.4 3349.6 603.7 607.5 608.5 608.9 621.0 660.7 677.7 734.8 743.9 757.1 9258.9 9429.0 9441.8 9518.2 9639.4 689.4 695.7 707.0 739.9 749.3 4201.7 4454.7 4557.9 4562.1 4602.9 53150.5 54207.0 54598.2 54609.2 54704.5 54395.5 55183.7 55567.4 56030.0 56135.4 48838.0 49505.5 50037.2 50062.7 50368.5 8486.4 8598.4 8684.2 8870.8 8958.6 36378.5 36510.6 36999.0 37209.1 37627.6 42476.8 42886.6 46296.0 48044.8 49052.3 10697.3 11892.5 12091.0 12346.1 12467.6 13134.2 13144.3 13318.7 13738.6 13836.4 12580.0 12752.8 12828.7 12967.2 12994.7 11640.6 11912.2 12030.6 12090.5 12365.7 11367.1 11420.2 12062.7 12755.0 12849.2 10597.7 10840.2 10964.7 11107.8 11127.2 10493.7 11082.2 11137.2 11170.7 11239.3 11:41:23 INFO - 2016-01-25 11:41:23,700 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:41:23 INFO - 2016-01-25 11:41:23,700 DEBUG : BROWSER_OUTPUT: 11:41:24 INFO - 2016-01-25 11:41:24,410 INFO : Browser exited with error code: 0 11:41:24 INFO - 2016-01-25 11:41:24,431 INFO : Completed test dromaeo_css (00:18:28) 11:41:24 INFO - 2016-01-25 11:41:24,431 INFO : Starting test kraken 11:41:24 INFO - 2016-01-25 11:41:24,431 DEBUG : operating with platform_type : linux_ 11:41:24 INFO - 2016-01-25 11:41:24,431 INFO : Initialising browser for kraken test... 11:41:24 INFO - 2016-01-25 11:41:24,437 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmnqv_Q/profile http://localhost:48055/getInfo.html 11:41:28 INFO - 2016-01-25 11:41:28,111 DEBUG : BROWSER_OUTPUT: 11:41:28 INFO - 2016-01-25 11:41:28,111 DEBUG : BROWSER_OUTPUT: (process:5909): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:41:28 INFO - 2016-01-25 11:41:28,966 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:41:28 INFO - 2016-01-25 11:41:28,966 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:41:28 INFO - 2016-01-25 11:41:28,966 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:41:28 INFO - 2016-01-25 11:41:28,966 DEBUG : BROWSER_OUTPUT: __metrics 11:41:29 INFO - 2016-01-25 11:41:29,917 INFO : Browser initialized. 11:41:29 INFO - 2016-01-25 11:41:29,918 INFO : Running cycle 1/1 for kraken test... 11:41:29 INFO - 2016-01-25 11:41:29,918 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmnqv_Q/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,208 DEBUG : BROWSER_OUTPUT: 11:41:31 INFO - 2016-01-25 11:41:31,209 DEBUG : BROWSER_OUTPUT: (process:6021): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:41:41 INFO - 2016-01-25 11:41:41,713 DEBUG : BROWSER_OUTPUT: RSS: Main: 136241152 11:41:41 INFO - 2016-01-25 11:41:41,713 DEBUG : BROWSER_OUTPUT: 11:41:44 INFO - 2016-01-25 11:41:44,195 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48055/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48055/tests/kraken/driver.html?testName=audio-beat-detection) 11:41:44 INFO - 2016-01-25 11:41:44,801 DEBUG : BROWSER_OUTPUT: RSS: Main: 137510912 11:41:44 INFO - 2016-01-25 11:41:44,801 DEBUG : BROWSER_OUTPUT: 11:41:47 INFO - 2016-01-25 11:41:47,397 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48055/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48055/tests/kraken/driver.html?testName=audio-dft) 11:41:47 INFO - 2016-01-25 11:41:47,987 DEBUG : BROWSER_OUTPUT: RSS: Main: 138399744 11:41:47 INFO - 2016-01-25 11:41:47,987 DEBUG : BROWSER_OUTPUT: 11:41:50 INFO - 2016-01-25 11:41:50,790 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48055/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48055/tests/kraken/driver.html?testName=audio-fft) 11:41:51 INFO - 2016-01-25 11:41:51,372 DEBUG : BROWSER_OUTPUT: RSS: Main: 139268096 11:41:51 INFO - 2016-01-25 11:41:51,372 DEBUG : BROWSER_OUTPUT: 11:41:53 INFO - 2016-01-25 11:41:53,396 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48055/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48055/tests/kraken/driver.html?testName=audio-oscillator) 11:41:53 INFO - 2016-01-25 11:41:53,989 DEBUG : BROWSER_OUTPUT: RSS: Main: 137969664 11:41:53 INFO - 2016-01-25 11:41:53,990 DEBUG : BROWSER_OUTPUT: 11:41:56 INFO - 2016-01-25 11:41:56,188 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48055/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48055/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:41:56 INFO - 2016-01-25 11:41:56,770 DEBUG : BROWSER_OUTPUT: RSS: Main: 138227712 11:41:56 INFO - 2016-01-25 11:41:56,770 DEBUG : BROWSER_OUTPUT: 11:41:59 INFO - 2016-01-25 11:41:59,714 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48055/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48055/tests/kraken/driver.html?testName=imaging-darkroom) 11:42:00 INFO - 2016-01-25 11:42:00,299 DEBUG : BROWSER_OUTPUT: RSS: Main: 139653120 11:42:00 INFO - 2016-01-25 11:42:00,299 DEBUG : BROWSER_OUTPUT: 11:42:03 INFO - 2016-01-25 11:42:03,653 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48055/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48055/tests/kraken/driver.html?testName=imaging-desaturate) 11:42:04 INFO - 2016-01-25 11:42:04,234 DEBUG : BROWSER_OUTPUT: RSS: Main: 139481088 11:42:04 INFO - 2016-01-25 11:42:04,235 DEBUG : BROWSER_OUTPUT: 11:42:06 INFO - 2016-01-25 11:42:06,994 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48055/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48055/tests/kraken/driver.html?testName=json-parse-financial) 11:42:07 INFO - 2016-01-25 11:42:07,575 DEBUG : BROWSER_OUTPUT: RSS: Main: 138510336 11:42:07 INFO - 2016-01-25 11:42:07,575 DEBUG : BROWSER_OUTPUT: 11:42:09 INFO - 2016-01-25 11:42:09,123 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48055/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48055/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:42:09 INFO - 2016-01-25 11:42:09,704 DEBUG : BROWSER_OUTPUT: RSS: Main: 138260480 11:42:09 INFO - 2016-01-25 11:42:09,704 DEBUG : BROWSER_OUTPUT: 11:42:11 INFO - 2016-01-25 11:42:11,455 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48055/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48055/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:42:12 INFO - 2016-01-25 11:42:12,064 DEBUG : BROWSER_OUTPUT: RSS: Main: 138817536 11:42:12 INFO - 2016-01-25 11:42:12,065 DEBUG : BROWSER_OUTPUT: 11:42:14 INFO - 2016-01-25 11:42:14,109 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48055/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48055/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:42:14 INFO - 2016-01-25 11:42:14,696 DEBUG : BROWSER_OUTPUT: RSS: Main: 138817536 11:42:14 INFO - 2016-01-25 11:42:14,696 DEBUG : BROWSER_OUTPUT: 11:42:17 INFO - 2016-01-25 11:42:17,112 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48055/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48055/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:42:17 INFO - 2016-01-25 11:42:17,706 DEBUG : BROWSER_OUTPUT: RSS: Main: 138854400 11:42:17 INFO - 2016-01-25 11:42:17,706 DEBUG : BROWSER_OUTPUT: 11:42:20 INFO - 2016-01-25 11:42:20,262 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48055/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48055/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:42:20 INFO - 2016-01-25 11:42:20,850 DEBUG : BROWSER_OUTPUT: RSS: Main: 138616832 11:42:20 INFO - 2016-01-25 11:42:20,851 DEBUG : BROWSER_OUTPUT: 11:42:22 INFO - 2016-01-25 11:42:22,525 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48055/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48055/tests/kraken/driver.html?testName=ai-astar) 11:42:22 INFO - 2016-01-25 11:42:22,775 DEBUG : BROWSER_OUTPUT: RSS: Main: 140210176 11:42:22 INFO - 2016-01-25 11:42:22,775 DEBUG : BROWSER_OUTPUT: 11:42:22 INFO - 2016-01-25 11:42:22,776 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:42:22 INFO - 2016-01-25 11:42:22,777 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:42:22 INFO - 2016-01-25 11:42:22,777 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:42:22 INFO - 2016-01-25 11:42:22,777 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:42:22 INFO - 2016-01-25 11:42:22,777 DEBUG : BROWSER_OUTPUT: |0;ai-astar;121;107;111;111;113;124;112;113;111;111 11:42:22 INFO - 2016-01-25 11:42:22,778 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;124;147;164;122;150;147;122;160;124 11:42:22 INFO - 2016-01-25 11:42:22,778 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;162;162;161;164;162;161;161;166;163 11:42:22 INFO - 2016-01-25 11:42:22,778 DEBUG : BROWSER_OUTPUT: |3;audio-fft;78;72;74;171;75;73;72;73;154;71 11:42:22 INFO - 2016-01-25 11:42:22,778 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;92;137;91;92;95;139;92;93;139 11:42:22 INFO - 2016-01-25 11:42:22,778 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;110;110;111;110;111;109;110 11:42:22 INFO - 2016-01-25 11:42:22,779 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;148;148;146;146;146;148;148;147;148 11:42:22 INFO - 2016-01-25 11:42:22,779 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;96;96;96;97;95;97;96 11:42:22 INFO - 2016-01-25 11:42:22,779 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;56;59;59;60;61;63;59;59;58;57 11:42:22 INFO - 2016-01-25 11:42:22,779 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;63;65;64;65;64;63;63;64;64 11:42:22 INFO - 2016-01-25 11:42:22,780 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;79;82;90;85;82;82;84;85;83;82 11:42:22 INFO - 2016-01-25 11:42:22,780 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;123;110;113;120;126;126;117;126;115;116 11:42:22 INFO - 2016-01-25 11:42:22,780 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;139;153;149;149;157;150;147;147;148;140 11:42:22 INFO - 2016-01-25 11:42:22,780 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;67;67;66;71;65;67;70;68;67 11:42:22 INFO - 2016-01-25 11:42:22,780 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:42:22 INFO - 2016-01-25 11:42:22,781 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:42:22 INFO - 2016-01-25 11:42:22,781 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,711 11:42:22 INFO - 2016-01-25 11:42:22,781 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:42:22 INFO - 2016-01-25 11:42:22,781 DEBUG : BROWSER_OUTPUT: __startTimestamp1453750942775__endTimestamp 11:42:22 INFO - 2016-01-25 11:42:22,781 DEBUG : BROWSER_OUTPUT: 11:42:22 INFO - 2016-01-25 11:42:22,785 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:42:22 INFO - 2016-01-25 11:42:22,785 DEBUG : BROWSER_OUTPUT: Number of tests: 14 11:42:22 INFO - 2016-01-25 11:42:22,785 DEBUG : BROWSER_OUTPUT: 11:42:22 INFO - 2016-01-25 11:42:22,785 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:113.40 Median:112.50 stddev:5.13 (4.6%) stddev-sans-first:4.64 11:42:22 INFO - 2016-01-25 11:42:22,785 DEBUG : BROWSER_OUTPUT: Values: 121.0 107.0 111.0 111.0 113.0 124.0 112.0 113.0 111.0 111.0 11:42:22 INFO - 2016-01-25 11:42:22,785 DEBUG : BROWSER_OUTPUT: 11:42:22 INFO - 2016-01-25 11:42:22,785 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.60 Median:148.50 stddev:16.88 (11.4%) stddev-sans-first:17.08 11:42:22 INFO - 2016-01-25 11:42:22,785 DEBUG : BROWSER_OUTPUT: Values: 156.0 124.0 147.0 164.0 122.0 150.0 147.0 122.0 160.0 124.0 11:42:22 INFO - 2016-01-25 11:42:22,785 DEBUG : BROWSER_OUTPUT: 11:42:22 INFO - 2016-01-25 11:42:22,786 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.30 Median:162.00 stddev:1.64 (1.0%) stddev-sans-first:1.67 11:42:22 INFO - 2016-01-25 11:42:22,786 DEBUG : BROWSER_OUTPUT: Values: 161.0 162.0 162.0 161.0 164.0 162.0 161.0 161.0 166.0 163.0 11:42:22 INFO - 2016-01-25 11:42:22,786 DEBUG : BROWSER_OUTPUT: 11:42:22 INFO - 2016-01-25 11:42:22,786 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:91.30 Median:73.00 stddev:37.79 (51.8%) stddev-sans-first:39.77 11:42:22 INFO - 2016-01-25 11:42:22,786 DEBUG : BROWSER_OUTPUT: Values: 78.0 72.0 74.0 171.0 75.0 73.0 72.0 73.0 154.0 71.0 11:42:22 INFO - 2016-01-25 11:42:22,786 DEBUG : BROWSER_OUTPUT: 11:42:22 INFO - 2016-01-25 11:42:22,786 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.30 Median:92.00 stddev:22.14 (24.1%) stddev-sans-first:22.95 11:42:22 INFO - 2016-01-25 11:42:22,786 DEBUG : BROWSER_OUTPUT: Values: 93.0 92.0 137.0 91.0 92.0 95.0 139.0 92.0 93.0 139.0 11:42:22 INFO - 2016-01-25 11:42:22,786 DEBUG : BROWSER_OUTPUT: 11:42:22 INFO - 2016-01-25 11:42:22,786 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 11:42:22 INFO - 2016-01-25 11:42:22,786 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 110.0 110.0 111.0 110.0 111.0 109.0 110.0 11:42:22 INFO - 2016-01-25 11:42:22,786 DEBUG : BROWSER_OUTPUT: 11:42:22 INFO - 2016-01-25 11:42:22,786 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.20 Median:148.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 11:42:22 INFO - 2016-01-25 11:42:22,786 DEBUG : BROWSER_OUTPUT: Values: 147.0 148.0 148.0 146.0 146.0 146.0 148.0 148.0 147.0 148.0 11:42:22 INFO - 2016-01-25 11:42:22,787 DEBUG : BROWSER_OUTPUT: 11:42:22 INFO - 2016-01-25 11:42:22,787 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 11:42:22 INFO - 2016-01-25 11:42:22,787 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 96.0 96.0 96.0 97.0 95.0 97.0 96.0 11:42:22 INFO - 2016-01-25 11:42:22,787 DEBUG : BROWSER_OUTPUT: 11:42:22 INFO - 2016-01-25 11:42:22,787 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.10 Median:59.00 stddev:1.97 (3.3%) stddev-sans-first:1.74 11:42:22 INFO - 2016-01-25 11:42:22,787 DEBUG : BROWSER_OUTPUT: Values: 56.0 59.0 59.0 60.0 61.0 63.0 59.0 59.0 58.0 57.0 11:42:22 INFO - 2016-01-25 11:42:22,787 DEBUG : BROWSER_OUTPUT: 11:42:22 INFO - 2016-01-25 11:42:22,787 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:63.80 Median:64.00 stddev:0.79 (1.2%) stddev-sans-first:0.78 11:42:22 INFO - 2016-01-25 11:42:22,787 DEBUG : BROWSER_OUTPUT: Values: 63.0 63.0 65.0 64.0 65.0 64.0 63.0 63.0 64.0 64.0 11:42:22 INFO - 2016-01-25 11:42:22,787 DEBUG : BROWSER_OUTPUT: 11:42:22 INFO - 2016-01-25 11:42:22,787 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:83.50 stddev:2.91 (3.5%) stddev-sans-first:2.62 11:42:22 INFO - 2016-01-25 11:42:22,787 DEBUG : BROWSER_OUTPUT: Values: 79.0 82.0 90.0 85.0 82.0 82.0 84.0 85.0 83.0 82.0 11:42:22 INFO - 2016-01-25 11:42:22,787 DEBUG : BROWSER_OUTPUT: 11:42:22 INFO - 2016-01-25 11:42:22,787 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:119.20 Median:121.50 stddev:5.87 (4.8%) stddev-sans-first:6.06 11:42:22 INFO - 2016-01-25 11:42:22,787 DEBUG : BROWSER_OUTPUT: Values: 123.0 110.0 113.0 120.0 126.0 126.0 117.0 126.0 115.0 116.0 11:42:22 INFO - 2016-01-25 11:42:22,788 DEBUG : BROWSER_OUTPUT: 11:42:22 INFO - 2016-01-25 11:42:22,788 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.90 Median:149.00 stddev:5.36 (3.6%) stddev-sans-first:4.62 11:42:22 INFO - 2016-01-25 11:42:22,788 DEBUG : BROWSER_OUTPUT: Values: 139.0 153.0 149.0 149.0 157.0 150.0 147.0 147.0 148.0 140.0 11:42:22 INFO - 2016-01-25 11:42:22,788 DEBUG : BROWSER_OUTPUT: 11:42:22 INFO - 2016-01-25 11:42:22,788 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:67.50 stddev:1.78 (2.6%) stddev-sans-first:1.88 11:42:22 INFO - 2016-01-25 11:42:22,788 DEBUG : BROWSER_OUTPUT: Values: 68.0 67.0 67.0 66.0 71.0 65.0 67.0 70.0 68.0 67.0 11:42:22 INFO - 2016-01-25 11:42:22,788 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:42:22 INFO - 2016-01-25 11:42:22,788 DEBUG : BROWSER_OUTPUT: 11:42:23 INFO - 2016-01-25 11:42:23,621 INFO : Browser exited with error code: 0 11:42:23 INFO - 2016-01-25 11:42:23,675 INFO : Completed test kraken (00:00:59) 11:42:23 INFO - 2016-01-25 11:42:23,675 INFO : Starting test v8_7 11:42:23 INFO - 2016-01-25 11:42:23,675 DEBUG : operating with platform_type : linux_ 11:42:23 INFO - 2016-01-25 11:42:23,675 INFO : Initialising browser for v8_7 test... 11:42:23 INFO - 2016-01-25 11:42:23,681 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMd0G0B/profile http://localhost:48055/getInfo.html 11:42:27 INFO - 2016-01-25 11:42:27,295 DEBUG : BROWSER_OUTPUT: 11:42:27 INFO - 2016-01-25 11:42:27,295 DEBUG : BROWSER_OUTPUT: (process:6329): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:42:28 INFO - 2016-01-25 11:42:28,143 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:42:28 INFO - 2016-01-25 11:42:28,143 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:42:28 INFO - 2016-01-25 11:42:28,144 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:42:28 INFO - 2016-01-25 11:42:28,144 DEBUG : BROWSER_OUTPUT: __metrics 11:42:29 INFO - 2016-01-25 11:42:29,089 INFO : Browser initialized. 11:42:29 INFO - 2016-01-25 11:42:29,090 INFO : Running cycle 1/1 for v8_7 test... 11:42:29 INFO - 2016-01-25 11:42:29,090 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMd0G0B/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,361 DEBUG : BROWSER_OUTPUT: 11:42:30 INFO - 2016-01-25 11:42:30,362 DEBUG : BROWSER_OUTPUT: (process:6438): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:42:40 INFO - 2016-01-25 11:42:40,865 DEBUG : BROWSER_OUTPUT: RSS: Main: 135610368 11:42:40 INFO - 2016-01-25 11:42:40,865 DEBUG : BROWSER_OUTPUT: 11:43:02 INFO - 2016-01-25 11:43:02,243 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48055/tests/v8_7/run.html (next: http://localhost:48055/tests/v8_7/run.html) 11:43:02 INFO - 2016-01-25 11:43:02,501 DEBUG : BROWSER_OUTPUT: RSS: Main: 135729152 11:43:02 INFO - 2016-01-25 11:43:02,501 DEBUG : BROWSER_OUTPUT: 11:43:02 INFO - 2016-01-25 11:43:02,501 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:43:02 INFO - 2016-01-25 11:43:02,501 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:43:02 INFO - 2016-01-25 11:43:02,501 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:43:02 INFO - 2016-01-25 11:43:02,501 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:43:02 INFO - 2016-01-25 11:43:02,502 DEBUG : BROWSER_OUTPUT: |0;Richards;166.55562958027983 11:43:02 INFO - 2016-01-25 11:43:02,502 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;166.72224074691565 11:43:02 INFO - 2016-01-25 11:43:02,502 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.09572983533354 11:43:02 INFO - 2016-01-25 11:43:02,502 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5170.103092783505 11:43:02 INFO - 2016-01-25 11:43:02,502 DEBUG : BROWSER_OUTPUT: |4;RayTrace;909.0909090909091 11:43:02 INFO - 2016-01-25 11:43:02,502 DEBUG : BROWSER_OUTPUT: |5;Earley;563.063063063063 11:43:02 INFO - 2016-01-25 11:43:02,502 DEBUG : BROWSER_OUTPUT: |6;Boyer;11133.333333333334 11:43:02 INFO - 2016-01-25 11:43:02,502 DEBUG : BROWSER_OUTPUT: |7;RegExp;24261.904761904763 11:43:02 INFO - 2016-01-25 11:43:02,503 DEBUG : BROWSER_OUTPUT: |8;Splay;524.6589716684156 11:43:02 INFO - 2016-01-25 11:43:02,503 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 11:43:02 INFO - 2016-01-25 11:43:02,503 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:43:02 INFO - 2016-01-25 11:43:02,503 DEBUG : BROWSER_OUTPUT: __startTimestamp1453750982494__endTimestamp 11:43:02 INFO - 2016-01-25 11:43:02,503 DEBUG : BROWSER_OUTPUT: 11:43:02 INFO - 2016-01-25 11:43:02,503 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:43:02 INFO - 2016-01-25 11:43:02,503 DEBUG : BROWSER_OUTPUT: Number of tests: 10 11:43:02 INFO - 2016-01-25 11:43:02,504 DEBUG : BROWSER_OUTPUT: 11:43:02 INFO - 2016-01-25 11:43:02,504 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.56 Median:166.56 stddev:0.00 (0.0%) 11:43:02 INFO - 2016-01-25 11:43:02,504 DEBUG : BROWSER_OUTPUT: Values: 166.6 11:43:02 INFO - 2016-01-25 11:43:02,504 DEBUG : BROWSER_OUTPUT: 11:43:02 INFO - 2016-01-25 11:43:02,504 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:166.72 Median:166.72 stddev:0.00 (0.0%) 11:43:02 INFO - 2016-01-25 11:43:02,504 DEBUG : BROWSER_OUTPUT: Values: 166.7 11:43:02 INFO - 2016-01-25 11:43:02,504 DEBUG : BROWSER_OUTPUT: 11:43:02 INFO - 2016-01-25 11:43:02,504 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.10 Median:279.10 stddev:0.00 (0.0%) 11:43:02 INFO - 2016-01-25 11:43:02,505 DEBUG : BROWSER_OUTPUT: Values: 279.1 11:43:02 INFO - 2016-01-25 11:43:02,505 DEBUG : BROWSER_OUTPUT: 11:43:02 INFO - 2016-01-25 11:43:02,505 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5170.10 Median:5170.10 stddev:0.00 (0.0%) 11:43:02 INFO - 2016-01-25 11:43:02,505 DEBUG : BROWSER_OUTPUT: Values: 5170.1 11:43:02 INFO - 2016-01-25 11:43:02,505 DEBUG : BROWSER_OUTPUT: 11:43:02 INFO - 2016-01-25 11:43:02,505 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:909.09 Median:909.09 stddev:0.00 (0.0%) 11:43:02 INFO - 2016-01-25 11:43:02,505 DEBUG : BROWSER_OUTPUT: Values: 909.1 11:43:02 INFO - 2016-01-25 11:43:02,506 DEBUG : BROWSER_OUTPUT: 11:43:02 INFO - 2016-01-25 11:43:02,506 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:563.06 Median:563.06 stddev:0.00 (0.0%) 11:43:02 INFO - 2016-01-25 11:43:02,506 DEBUG : BROWSER_OUTPUT: Values: 563.1 11:43:02 INFO - 2016-01-25 11:43:02,506 DEBUG : BROWSER_OUTPUT: 11:43:02 INFO - 2016-01-25 11:43:02,506 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11133.33 Median:11133.33 stddev:0.00 (0.0%) 11:43:02 INFO - 2016-01-25 11:43:02,506 DEBUG : BROWSER_OUTPUT: Values: 11133.3 11:43:02 INFO - 2016-01-25 11:43:02,506 DEBUG : BROWSER_OUTPUT: 11:43:02 INFO - 2016-01-25 11:43:02,506 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24261.90 Median:24261.90 stddev:0.00 (0.0%) 11:43:02 INFO - 2016-01-25 11:43:02,507 DEBUG : BROWSER_OUTPUT: Values: 24261.9 11:43:02 INFO - 2016-01-25 11:43:02,507 DEBUG : BROWSER_OUTPUT: 11:43:02 INFO - 2016-01-25 11:43:02,507 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:524.66 Median:524.66 stddev:0.00 (0.0%) 11:43:02 INFO - 2016-01-25 11:43:02,507 DEBUG : BROWSER_OUTPUT: Values: 524.7 11:43:02 INFO - 2016-01-25 11:43:02,507 DEBUG : BROWSER_OUTPUT: 11:43:02 INFO - 2016-01-25 11:43:02,507 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,507 DEBUG : BROWSER_OUTPUT: Values: 4835.7 11:43:02 INFO - 2016-01-25 11:43:02,508 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:43:02 INFO - 2016-01-25 11:43:02,508 DEBUG : BROWSER_OUTPUT: 11:43:03 INFO - 2016-01-25 11:43:03,297 INFO : Browser exited with error code: 0 11:43:03 INFO - 2016-01-25 11:43:03,309 INFO : Completed test v8_7 (00:00:39) 11:43:03 INFO - 2016-01-25 11:43:03,519 INFO : Completed test suite (00:20:07) 11:43:03 INFO - 2016-01-25 11:43:03,519 DEBUG : Working with test: dromaeo_css 11:43:03 INFO - 2016-01-25 11:43:03,519 DEBUG : Generating results file: dromaeo_css 11:43:03 INFO - 2016-01-25 11:43:03,520 DEBUG : Working with test: kraken 11:43:03 INFO - 2016-01-25 11:43:03,520 DEBUG : Generating results file: kraken 11:43:03 INFO - 2016-01-25 11:43:03,521 INFO : javascript benchmark 11:43:03 INFO - 2016-01-25 11:43:03,521 DEBUG : Working with test: v8_7 11:43:03 INFO - 2016-01-25 11:43:03,521 DEBUG : Generating results file: v8_7 11:43:03 INFO - 2016-01-25 11:43:03,521 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,591 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 11:43:03 INFO - 2016-01-25 11:43:03,591 DEBUG : process_Request line: dromaeo_css 7228.92 graph.html#tests=[[72,52,43]] 11:43:03 INFO - 2016-01-25 11:43:03,591 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,623 DEBUG : process_Request line: kraken 1509.30 graph.html#tests=[[232,52,43]] 11:43:03 INFO - 2016-01-25 11:43:03,623 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,656 DEBUG : process_Request line: v8_7 23154.67 graph.html#tests=[[230,52,43]] 11:43:03 INFO - 2016-01-25 11:43:03,658 INFO : javascript benchmark 11:43:03 INFO - 2016-01-25 11:43:03,661 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3243.967560324397, 3259.3970115528646, 3288.1286459088346, 3311.7516186286025, 3318.5851768528933, 5517.420670829565, 5526.447355264477, 5532.419095994923, 5532.446755324466, 5559.722013899309, 5559.638623489471, 5584.52531534819, 5601.439856014396, 5603.215549823028, 5663.886722265553, 5078.111330517163, 5122.078025955327, 5188.584913206953, 5206.349206349207, 5237.947620523803, 4814.614830813544, 5029.094762942669, 5032.295478632995, 5087.491250874901, 5217.321748172732, 4999.550040496355, 5072.72100034498, 5084.4661310562415, 5087.898242035157, 5209.635325527214, 5145.76844042019, 5158.664686795346, 5161.458046905096, 5177.870553236162, 5189.273501709764, 4882.170031094687, 4966.87582810429, 5012.097822391968, 5083.61872859537, 5094.566961808251, 5260.736963151827, 5372.892542149174, 5389.5688344932705, 5393.622446428752, 5397.082495975655, 5890.793822216202, 5928.40715928408, 5932.317783454915, 5950.315713692938, 5989.251343582052, 5712.057510510761, 5853.385394533555, 5922.911156332659, 5995.010823214165, 6027.578069535134, 5643.802466913679, 5646.096624540095, 5656.095024796013, 5656.179853921159, 5660.575456840712, 6147.72335244915, 6149.13912052313, 6167.876642467215, 6176.505879529627, 6177.876442471125, 5672.801451949244, 5747.0, 5749.8275051748515, 5872.324682661463, 5890.528757699374, 5839.299284085937, 5929.73316200772, 5953.434423729739, 5987.2815262168815, 6007.249093863267, 5788.102844059177, 5862.94137058624, 5886.23478947734, 5891.764329426861, 5933.9406605934255, 5757.568182386338, 5847.0, 5855.151003104611, 5863.70681465925, 5874.647521148745, 4537.4328208973875, 4551.3173024046, 4564.7717614119165, 4575.908481830411, 4577.450705915311, 3978.5822488638278, 4052.473178486837, 4080.1431699342875, 4105.384192371109, 4128.298189307825, 5528.668279903219, 5583.581231407579, 5589.329280486368, 5614.719264036782, 5643.068893632505, 5988.550858685616, 6030.095485677183, 6037.396260374016, 6046.3651316612, 6046.909296360558, 5478.835634930959, 5564.721763911869, 5689.687067211343, 5735.1970724098655, 5748.597598168171, 5094.235864620263, 5096.61775366849, 5136.948630513722, 5142.820001299937, 5185.533302002762, 5976.850578735566, 5998.940010599926, 6004.099385092271, 6009.248843894513, 6017.247844019497, 5765.538756899522, 5888.028475301699, 5929.466348028698, 5990.1913241713555, 6110.480609148272, 6138.0, 6141.508679305734, 6142.3550527194, 6143.293521244936, 6143.32423433413, 5862.530997520274, 5923.674197919156, 5945.821625351246, 5949.077892926603, 5958.612690175125, 5714.714264286686, 5866.560007999503, 5921.822345329647, 6014.699265036818, 6057.878842423215, 5860.062390017577, 5917.881642367042, 5918.023526118314, 5919.378465261086, 5920.615160014585, 5655.745491452977, 5904.793332233351, 5904.940950590439, 5907.291125064848, 5922.052471604523, 5606.579506536945, 5641.858953526031, 5686.033374326292, 5711.714414279187, 5717.42825717425, 5812.21535092757, 5814.156947242711, 5818.040023396262, 5846.976779063732, 5855.531557475307, 5615.5507559395965, 5648.378678345461, 5719.084946408555, 5735.254416925773, 5744.368119506935], "unit": "ms", "name": "dojo.html", "value": 5483.0479452963355}, {"lowerIsBetter": false, "replicates": [588.7968650815467, 625.3808729357937, 626.1484381241511, 628.7987843889956, 630.1618846933579, 43179.0, 43562.782186089105, 44095.999999999956, 44124.11751764967, 44196.55803441965, 45824.083518329615, 46442.303365449545, 46488.53511464885, 46507.0, 46556.301655475196, 8964.238039766627, 9073.09269073094, 9162.0, 9165.266778657724, 9191.586378612945, 8806.163414475646, 8898.86651700225, 8946.910530894673, 8956.641734330651, 8990.37067405282, 9017.053209412983, 9094.226990705798, 9103.180713735763, 9114.27085833135, 9117.95441022794, 8929.910700892973, 8945.418547794372, 8995.0, 9030.367874248805, 9030.638774449048, 8797.0, 9057.275417966546, 9076.546172691405, 9082.545872706338, 9097.954510227406, 43273.35089973653, 43683.78158109221, 44052.77973610144, 44151.33772993408, 44217.11565768699, 3544.1848374873666, 3636.8727094551564, 3832.8466861325514, 4196.475440569929, 4317.136572685476, 33611.831940840384, 33719.494207586664, 33748.49377259343, 33760.32479350399, 34992.125196870285, 3684.7420680552373, 3730.011546940063, 3732.533433320835, 3736.794476303802, 3880.3597406427907, 281283.0, 285009.0, 285219.0, 286232.0, 286952.0, 64751.352486474534, 65092.34907650958, 65181.67409162924, 65207.0, 65366.34633653603, 68374.0, 68516.6574167126, 68534.65732671304, 68669.0, 68711.65644171747, 16048.438304659281, 16307.1031093291, 16489.752653710202, 16518.2566784495, 16599.0, 13379.397927093305, 13403.195808251536, 13457.596272111656, 13517.864821351857, 13523.797143042862, 21812.563748724937, 21875.234366797085, 22126.668099978513, 22136.778632213794, 22224.222152224916, 7805.882911756328, 8037.196280371916, 8055.0, 8098.473599216032, 8118.918810811934, 1054.2620165883911, 1089.983650245247, 1116.3469370418234, 1138.3966497756203, 1213.9939300303618, 29811.0, 29957.251068723457, 30230.54654180189, 30382.84808575943, 30689.386212276077, 1040.360178490223, 1062.1927335225284, 1063.984040239397, 1080.7892460970036, 1108.0913650806262, 14251.786223206453, 14302.928485357506, 14380.137191768526, 14584.270786460635, 14650.340734666752, 347585.0, 355507.0, 358041.0, 361254.0, 506327.0, 48625.27062094071, 48977.26534101991, 49003.26495102576, 49017.75491122593, 49081.75459122682, 1472.5803146103524, 1478.4529724002189, 1487.5016869348674, 1490.8136482939633, 1602.671452352265, 28760.71239287664, 29941.70058299389, 30104.548431773102, 30283.242918927204, 30333.393332133674, 48169.27746083742, 48257.5174248253, 48282.275765864244, 48316.27525587049, 48388.51611483981, 265932.0, 266280.0, 267241.0, 267898.0, 268607.0, 33195.0, 33263.66736332606, 33622.0, 36116.63883361133, 36157.27685446329, 43857.0, 44015.339769904116, 44175.0, 44437.333439997776, 45368.546314536434, 38249.80875095718, 38266.23467530578, 38338.0, 38611.420828688155, 38894.80552597219, 38819.0, 40733.79633101934, 40958.5664501741, 40971.79514102411, 41540.1691966165, 35651.46522802108, 35688.643113568534, 35946.0, 36023.819880900424, 38341.80829095837, 31835.840820795747, 33079.0, 33773.662263378035, 34215.31569368648, 34573.30853382969, 25695.614565781903, 25951.0, 26161.345966350993, 26371.736282637696, 26454.735452645997], "unit": "ms", "name": "ext.html", "value": 19641.822301957076}, {"lowerIsBetter": false, "replicates": [386.7872670031482, 388.5298788465956, 389.08370786797093, 393.07234925575636, 394.9131191137949, 17971.64056718865, 18209.453716388514, 18734.250629974784, 20105.296314628973, 20160.495987600298, 16849.07330096844, 16887.071211083385, 16904.492865214033, 16927.407540736076, 17055.317787288524, 5006.123928312549, 5125.564327032207, 5131.255967884655, 5134.460881607433, 5149.382074151107, 5103.209002604603, 5283.63014588979, 5486.972565137169, 5515.117581187011, 5515.365732940723, 5459.208414779854, 5467.0, 5480.506754392104, 5502.119660854264, 5699.2306038684865, 5576.609637325369, 5607.186957891083, 5627.915581266284, 5633.211350410946, 5643.830685079454, 5170.224466330043, 5429.67421954684, 5432.565394768409, 5525.778968841241, 5597.076482380402, 13529.864701353057, 13749.31253437334, 13788.93105534466, 13832.861671383258, 14314.0, 2184.8907554622206, 2224.1881713174735, 2247.2471721973156, 2271.8750468724215, 2297.5634629420356, 10404.063634272952, 10407.479626018745, 10534.473276336152, 10559.313644613076, 10672.359658420519, 1919.6928491441442, 1919.7120431935182, 1961.8234358907766, 1978.9808248751904, 1987.7117817916321, 63352.68323658398, 64692.67653661749, 65536.6723166386, 66299.0, 66784.33215667878, 10743.785124297627, 10905.18211134168, 10920.617778377877, 10976.067034302014, 10978.341299522055, 14200.573982780534, 14268.57194284173, 14320.785188222186, 14350.282485875665, 14382.208978506073, 7995.440319177718, 8032.196780321921, 8212.219839115274, 8231.711890083818, 8248.752537423887, 7901.644426000844, 7939.245771651684, 7941.166177551274, 7964.402669799788, 8021.2379823916635, 4651.418572678415, 4674.509176536482, 4737.0, 4781.95218047822, 4856.465788763233, 1956.3544030469911, 1970.0740651893586, 2033.196887229536, 2039.9184032638825, 2063.1953538120147, 491.8008206676302, 495.0519754669839, 509.571959553969, 930.6463543853292, 1126.1272513801869, 11740.647780566596, 11864.347460889734, 11899.34553599543, 11981.46083426248, 12010.75978480443, 485.8712441203084, 492.7979528393413, 494.675987228366, 510.02585062530386, 520.47432093585, 6007.879842403127, 6429.839254018687, 6508.544401891822, 6523.673816309166, 6548.639824809681, 635994.0, 642901.0, 643372.0, 646228.0, 646817.0, 86564.0, 87264.56367718121, 87751.56124219338, 88585.0, 88965.55517222373, 527.7888844462245, 530.7744208711282, 531.0865311663932, 531.418097183591, 532.1379365428031, 10878.075363593867, 10987.0, 11093.445327733742, 11141.83287250708, 11237.887621123684, 35204.823975879954, 35461.0, 36047.098822529646, 36095.0, 36644.63355366519, 49608.50391496039, 49704.75147624239, 50025.24962125644, 51317.486825132764, 51567.0, 10131.7467063324, 10175.084242418217, 10399.844002340122, 10458.895411045793, 10591.788164236517, 17895.19471623754, 18334.174962127003, 18435.354762583243, 18576.628467430844, 18769.90615046916, 15011.174385408907, 15055.698886021999, 15170.0, 15708.371665133267, 15839.445619403266, 14983.0, 15324.310406031978, 15400.922995384952, 15494.612634684223, 15654.530364089096, 15016.399344026117, 15031.248437578297, 15210.46763363277, 15501.0, 15524.767128492857, 10278.537465814206, 10382.478195098376, 10399.688009359732, 10527.368357898551, 10532.684019479122, 11222.541069660892, 11269.04213141892, 14102.78845817293, 15798.289076991334, 15891.523254302389], "unit": "ms", "name": "jquery.html", "value": 8563.069536152158}, {"lowerIsBetter": false, "replicates": [1519.460591490021, 1523.7485814840552, 1768.3899054826081, 1829.204296131183, 1860.5999710062333, 7708.691652333907, 7858.0, 7859.76420707379, 7885.053793544768, 7990.320822730075, 8046.235607617282, 8086.110527841947, 8110.0, 8154.673813047486, 8159.388045896551, 2082.4481512399225, 2086.8330533557278, 2087.2381580723004, 2099.88450635215, 2143.099898042818, 2225.310153852303, 2257.9209727659536, 2266.4900397410534, 2278.6582012698145, 2280.2133264023887, 2131.7548481924623, 2168.0, 2173.4131784418196, 2287.0965968442456, 2304.3547806614174, 2291.3813270416895, 2312.976870231293, 2338.543983923136, 2340.2511196417154, 2347.1902193743217, 2270.829687773407, 2327.418145463634, 2332.755060718617, 2334.26470661741, 2334.953300933989, 7792.571408572526, 7852.489588176807, 7870.409719271021, 7881.684732610746, 7905.249001344863, 4554.544545545452, 4616.838410655611, 4622.468416132154, 4628.305754136873, 4635.188841952645, 2964.8962286319875, 2976.1369202931123, 3034.757219422463, 3040.011996101276, 3046.7410270127066, 989.6931951095112, 992.3103443107043, 999.0858364596386, 1011.3274672342883, 1030.319988807391, 10454.477276136162, 10466.68599942003, 10503.317284376491, 10529.36823790575, 10546.209034322457, 4035.5157381114454, 4051.8784436466954, 4069.1658210066867, 4097.385392191195, 4188.8115034822895, 8717.389782715149, 8717.607707653171, 8722.215000649972, 8736.519491427905, 8754.343424243207, 4596.701214421052, 4623.537646235417, 4637.234856248681, 4652.720836749806, 4662.7202367858035, 4281.850135245251, 4303.849365272201, 4316.179925814148, 4330.41539392178, 4343.066240758252, 3478.426059700121, 3487.2502411981545, 3503.0, 3526.753127281117, 3529.3647143514413, 1043.3062013760916, 1050.7635781949, 1054.981942425563, 1058.3755584205355, 1064.414571985405, 1088.711491454765, 1095.7479779650726, 1163.33689796815, 1335.3123141582093, 1416.9716605668036, 7354.114330167122, 7372.0, 7385.261473852679, 7418.777436676908, 7439.590822504706, 1149.9195056345975, 1153.8326942593444, 1155.856071485558, 1175.2948231061296, 1179.3582375478866, 6000.579959402888, 6065.120557519135, 6083.908741368883, 6092.208012958287, 6094.8171554853425, 8550.700725474579, 8852.114788521225, 8920.24177944882, 8930.240929521064, 8951.239144672645, 8794.86807697885, 8812.427192232484, 8879.822403551892, 8886.777830554158, 8889.155530224618, 7279.526830755984, 7306.452016098814, 7364.042674452394, 7367.63161841895, 7406.0, 7186.46101542376, 7213.2065472799, 7237.819054523679, 7261.5280006799385, 7318.194998550049, 8225.753227403187, 8232.0, 8352.83294334122, 8452.830943380975, 8496.53269070207, 8514.91485085166, 8523.616437260214, 8585.82828343442, 8636.784080397789, 8678.479291242546, 6931.2375638678695, 7218.133823941161, 7238.6380680966795, 7242.420606351585, 7249.456290778107, 7526.0, 7562.659680314289, 7598.8100297493, 7605.961970190114, 7642.197569255148, 6267.811965641038, 6803.863922721617, 6847.161572052401, 7009.369156775914, 7267.890981635174, 6555.6066636002, 6635.63504007265, 7054.682539285642, 7080.114985626797, 7244.673989670372, 7301.342879140902, 7307.744228951961, 7307.963460182665, 7386.2613738625705, 7389.408847292311, 6497.707603157774, 6512.967435162794, 6556.606603603799, 6591.769288074895, 6598.472122230114, 6809.38715515606, 6875.828104297232, 6883.896741548981, 6934.791956241321, 6935.653217339213], "unit": "ms", "name": "mootools.html", "value": 4490.376749997395}, {"lowerIsBetter": false, "replicates": [344.12763644162044, 352.6332614081355, 355.54490252476836, 355.59284619111116, 357.5834153211509, 6226.159468471755, 6294.0558916162545, 6298.0, 6369.777057802978, 6466.902996455057, 6242.126102345664, 6323.6521991290465, 6331.0, 6334.271558770743, 6344.111824344595, 4799.952000480003, 4801.927971080419, 4803.711777293365, 4810.97594512027, 4822.180229361017, 4792.664513484057, 4798.256270278112, 4801.591864691488, 4811.398575178103, 4816.54242846929, 4694.694844835092, 4722.858314250578, 4745.359376484183, 4768.094062128202, 4772.880677983061, 4704.45898721648, 4741.644376671747, 4751.216049351853, 4759.643026772988, 4767.737774422405, 4124.237016152021, 4129.401236820644, 4138.296489596776, 4139.441175441337, 4141.627253547165, 5971.0, 5997.4002599740115, 6015.518758499309, 6024.939750602482, 6033.245844269466, 5411.83764487066, 5453.318335208099, 5504.394516603171, 5505.311836020497, 5521.889562208774, 6641.302663220389, 6642.136522252124, 6644.0, 6644.368784965421, 6648.335166483313, 4544.545545445462, 4545.477270113913, 4548.363229147922, 4550.817967281305, 4550.977245113753, 6827.249002609709, 6915.308469153095, 6978.790636280869, 6980.546264492842, 7000.474964377641, 4731.124741922756, 4757.5718185363485, 4757.95242047582, 4758.405199350082, 4759.214729569582, 4808.831690890872, 4820.373351464287, 4823.493533179036, 4827.662063655511, 4830.9371938173545, 5525.613207075467, 5529.585281103933, 5532.2531458253425, 5536.335639723259, 5536.695481748462, 6526.575772574767, 6615.4046135848, 6658.5671931324305, 6667.266600673922, 6667.49993750461, 1661.4434164554768, 1681.2770508681385, 1699.9490015299561, 1701.3194722111007, 1703.3101593854508, 1141.9828702569469, 1165.3066425476827, 1165.5862168930078, 1168.5033860609208, 1178.5698220149754, 6423.13287706163, 6449.806505804833, 6449.96775016122, 6451.0, 6477.4494167996245, 6838.7264509419065, 6860.931390686029, 6873.690683919235, 6875.3124687531845, 6898.344657257552, 6350.396712312323, 6387.425131738166, 6416.165898433267, 6420.390062944013, 6428.260750013715, 3718.8698395556567, 3719.2189640175866, 3721.6650501455, 3734.3278209922473, 3747.4004159334377, 6920.238773734885, 6943.89584156238, 6959.338862808025, 7008.474364422688, 7035.401990830735, 6828.351306625863, 6922.307769223037, 6929.653517324114, 6933.826654333682, 6963.234044255128, 6980.336867997532, 6998.125234345707, 7007.194172670208, 7014.92985070153, 7016.5088443808445, 6790.25307216196, 6839.863202735818, 6862.4853136016, 6863.794086177422, 6864.691088900911, 6650.570127422628, 6698.162729658793, 6698.631575263407, 6736.5958042517605, 6812.65936703153, 7139.286071392819, 7139.643017849191, 7189.784306470814, 7197.71209151628, 7212.675429605575, 4636.072785442992, 4645.5354464553275, 4697.0, 4700.177468942989, 4712.717236965793, 6887.035814985806, 7013.929860701328, 7018.2630823762765, 7050.083489146378, 7064.399526040139, 6798.660066996729, 6834.897476537955, 6842.623655698984, 6853.7943861684225, 6865.553739007149, 6806.489513286424, 6815.488838337045, 6826.795196144124, 6828.385445309946, 6834.0, 6594.439472644879, 6679.799606011828, 6684.966575167093, 6691.966540167268, 6707.128073350434, 6696.229933557704, 6752.459803215633, 6758.357955994173, 6782.694778735067, 6808.455323574003, 6664.766733164316, 6675.365840245169, 6675.9666201670625, 6682.899756503559, 6688.431483323972], "unit": "ms", "name": "prototype.html", "value": 5035.942155586716}, {"lowerIsBetter": false, "replicates": [862.2584577263552, 954.0864547579966, 957.0525180071727, 958.9328746987709, 968.0996673094022, 14672.19302938338, 14884.25578721065, 14888.032277901943, 14932.626684332898, 15002.774958375632, 14323.85676143241, 14448.349824257908, 14471.638209044779, 14475.638109047279, 14493.855061449382, 911.5943405184695, 927.7355953553239, 930.3394589841187, 935.3966691483989, 949.5679465843025, 914.4833169259347, 915.327234482658, 924.0482303227652, 924.3021518753332, 924.574695640003, 953.9952300238489, 954.0173621170205, 955.5795450001976, 961.5096300886563, 963.8602402651611, 946.1815529566875, 951.3483263964172, 956.5743244256308, 958.4824194934727, 958.8657587937695, 703.3810246982623, 705.587231469591, 707.8195060259652, 709.163187438822, 712.5083692252381, 15054.172020538866, 15174.468893588672, 15220.543383698507, 15230.695386092328, 15237.390504379922, 12051.369110627365, 12265.938670306681, 12322.630321090382, 12365.38173091342, 12712.809307860389, 11388.487518061707, 11636.0, 12030.578929737418, 12045.939770301093, 12118.601265634787, 3865.439511270878, 3954.2882281189372, 3965.167314863882, 3973.165635216608, 4053.6959728020515, 52166.7391663043, 52543.73728131373, 52842.73578632121, 53125.73437132828, 53218.46781532174, 9906.356086854332, 10025.147862431775, 10130.797384052277, 10551.894481055244, 10940.507677154546, 19226.0, 19382.8061719381, 19463.610727785366, 19505.219791208478, 19508.609827803364, 7586.772396828104, 7751.224877512203, 7895.526268423913, 8000.079990801016, 8014.398920081017, 4000.759384898242, 4023.275810354164, 4105.220008198433, 4122.154958233615, 4140.751554906716, 3268.0686004488607, 3323.5513205717402, 3330.750193735431, 3342.4317865962844, 3349.564556607674, 603.7102190948369, 607.5018484842387, 608.4736702752087, 608.9482393996472, 620.965846878417, 660.7125900233414, 677.6882633988322, 734.8236423258379, 743.8809790433505, 757.1179575794138, 9258.861117083248, 9428.95285523568, 9441.811163776685, 9518.238540916711, 9639.421634701941, 689.3864460630043, 695.7286658203304, 706.9893951590731, 739.9260073992558, 749.3405802893419, 4201.7268877522865, 4454.732716037048, 4557.863264102082, 4562.087582483517, 4602.884927876763, 53150.493318346445, 54207.0, 54598.18102728383, 54609.180862287096, 54704.45295546993, 54395.45604543904, 55183.72408137934, 55567.44432555704, 56030.0, 56135.43864561384, 48838.0, 49505.50494495081, 50037.24944125841, 50062.749686251336, 50368.49631503711, 8486.405951583576, 8598.39811213209, 8684.161032636293, 8870.778230544289, 8958.641654334015, 36378.45432318465, 36510.63489365178, 36999.0, 37209.069773255884, 37627.623723762415, 42476.78761606172, 42886.57113428951, 46296.0, 48044.759776200895, 49052.26421603608, 10697.3046751964, 11892.46483908209, 12091.0, 12346.13577049598, 12467.563635272722, 13134.211947283193, 13144.34278286101, 13318.667033324244, 13738.587842364745, 13836.377363018488, 12580.0, 12752.808707869575, 12828.679283017998, 12967.22196668203, 12994.675133121747, 11640.592579260025, 11912.225705329125, 12030.63908082759, 12090.51637934508, 12365.690857728629, 11367.090632749525, 11420.172772356384, 12062.698432539257, 12755.002962690038, 12849.229046257255, 10597.682069537927, 10840.241183117107, 10964.725881853017, 11107.777844443228, 11127.1654625905, 10493.685189444328, 11082.224244303145, 11137.164712646421, 11170.664880053611, 11239.325640461599], "unit": "ms", "name": "yui.html", "value": 6842.35401699473}], "name": "dromaeo_css", "value": 7228.919506699232}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [121.0, 107.0, 111.0, 111.0, 113.0, 124.0, 112.0, 113.0, 111.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 113.4}, {"lowerIsBetter": true, "replicates": [156.0, 124.0, 147.0, 164.0, 122.0, 150.0, 147.0, 122.0, 160.0, 124.0], "unit": "ms", "name": "audio-beat-detection", "value": 141.6}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 162.0, 161.0, 164.0, 162.0, 161.0, 161.0, 166.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 162.3}, {"lowerIsBetter": true, "replicates": [78.0, 72.0, 74.0, 171.0, 75.0, 73.0, 72.0, 73.0, 154.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 91.3}, {"lowerIsBetter": true, "replicates": [93.0, 92.0, 137.0, 91.0, 92.0, 95.0, 139.0, 92.0, 93.0, 139.0], "unit": "ms", "name": "audio-oscillator", "value": 106.3}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 111.0, 110.0, 111.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 148.0, 146.0, 146.0, 146.0, 148.0, 148.0, 147.0, 148.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 95.0, 97.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [56.0, 59.0, 59.0, 60.0, 61.0, 63.0, 59.0, 59.0, 58.0, 57.0], "unit": "ms", "name": "json-parse-financial", "value": 59.1}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 65.0, 64.0, 65.0, 64.0, 63.0, 63.0, 64.0, 64.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 63.8}, {"lowerIsBetter": true, "replicates": [79.0, 82.0, 90.0, 85.0, 82.0, 82.0, 84.0, 85.0, 83.0, 82.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 83.4}, {"lowerIsBetter": true, "replicates": [123.0, 110.0, 113.0, 120.0, 126.0, 126.0, 117.0, 126.0, 115.0, 116.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 119.2}, {"lowerIsBetter": true, "replicates": [139.0, 153.0, 149.0, 149.0, 157.0, 150.0, 147.0, 147.0, 148.0, 140.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 147.9}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 67.0, 66.0, 71.0, 65.0, 67.0, 70.0, 68.0, 67.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 67.6}], "name": "kraken", "value": 1509.3000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.55562958027983], "unit": "score", "name": "Richards", "value": 211.95320800000005}, {"lowerIsBetter": false, "replicates": [166.72224074691565], "unit": "score", "name": "DeltaBlue", "value": 396.575764}, {"lowerIsBetter": false, "replicates": [279.09572983533354], "unit": "score", "name": "Encrypt", "value": 953.7265229999995}, {"lowerIsBetter": false, "replicates": [5170.103092783505], "unit": "score", "name": "Decrypt", "value": 51.48466001994015}, {"lowerIsBetter": false, "replicates": [909.0909090909091], "unit": "score", "name": "RayTrace", "value": 813.9879}, {"lowerIsBetter": false, "replicates": [563.063063063063], "unit": "score", "name": "Earley", "value": 1183.638288}, {"lowerIsBetter": false, "replicates": [11133.333333333334], "unit": "score", "name": "Boyer", "value": 59.86194610778439}, {"lowerIsBetter": false, "replicates": [24261.904761904763], "unit": "score", "name": "RegExp", "value": 37.547958783120734}, {"lowerIsBetter": false, "replicates": [524.6589716684156], "unit": "score", "name": "Splay", "value": 155.321846}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 23154.672858334492}]} 11:43:03 INFO - RETURN: dromaeo_css: 7228.92 11:43:03 INFO - RETURN: kraken: 1509.30 11:43:03 INFO - RETURN: v8_7: 23154.67 11:43:03 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "23154.67"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1509.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7228.92"}}} 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: 1224s; CPU: 13.0%; Read bytes: 0; Write bytes: 436056064; Read time: 0; Write time: 348000 11:43:04 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 160165888; Read time: 0; Write time: 189784 11:43:04 INFO - run-tests - Wall time: 1209s; CPU: 13.0%; Read bytes: 0; Write bytes: 275890176; Read time: 0; Write time: 158216 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=1263.057910 ========= master_lag: 0.33 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-01-25 11:43:03.934789) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-25 11:43:03.939799) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=934fc3100db09dcb9af4d4b6000001ab-1453749719.569958-536710323 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.009986 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.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-25 11:43:03.965757) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:43:03.966126) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=934fc3100db09dcb9af4d4b6000001ab-1453749719.569958-536710323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004564 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:43:04.015987) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 11:43:04.016288) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 11:43:04.017753) ========= ========= Total master_lag: 0.62 =========