builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-061 starttime: 1453749719.25 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.251362) ========= 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.251740) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 11:21:59.252017) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1453749718.621086-22118459 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006251 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 11:21:59.274207) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 11:21:59.274509) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 11:21:59.288757) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:21:59.289021) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1453749718.621086-22118459 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004516 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:21:59.337832) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 11:21:59.338118) ========= 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.338470) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:21:59.338739) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1453749718.621086-22118459 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-25 11:21:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.5M=0s 2016-01-25 11:21:59 (43.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.093226 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:21:59.444216) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:21:59.444531) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1453749718.621086-22118459 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022272 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:21:59.493738) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:21:59.494056) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1453749718.621086-22118459 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-25 11:21:59,657 truncating revision to first 12 chars 2016-01-25 11:21:59,657 Setting DEBUG logging. 2016-01-25 11:21:59,658 attempt 1/10 2016-01-25 11:21:59,658 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:21:59,907 unpacking tar archive at: mozilla-aurora-3bfa5bc61b62/testing/mozharness/ program finished with exit code 0 elapsedTime=0.532851 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:22:00.040129) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 11:22:00.040620) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1453749718.621086-22118459 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 3bfa5bc61b626761d487b45c170b115259f69d6b program finished with exit code 0 elapsedTime=0.003399 script_repo_revision: '3bfa5bc61b626761d487b45c170b115259f69d6b' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 11:22:00.088171) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 11:22:00.088508) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 11:22:00.098350) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-01-25 11:22:00.098647) ========= /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=516f8d7ca085b4d087ab0a71000001a4-1453749718.621086-22118459 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:22:00 INFO - MultiFileLogger online at 20160125 11:22:00 in /builds/slave/test-pgo 11:22:00 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:00 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 11:22:00 INFO - {'append_to_log': False, 11:22:00 INFO - 'base_work_dir': '/builds/slave/test-pgo', 11:22:00 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:22:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 11:22:00 INFO - 'branch': 'Mozilla-Aurora', 11:22:00 INFO - 'buildbot_json_path': 'buildprops.json', 11:22:00 INFO - 'config_files': ('talos/linux_config.py',), 11:22:00 INFO - 'default_actions': ('clobber', 11:22:00 INFO - 'read-buildbot-config', 11:22:00 INFO - 'download-and-extract', 11:22:00 INFO - 'populate-webroot', 11:22:00 INFO - 'create-virtualenv', 11:22:00 INFO - 'install', 11:22:00 INFO - 'run-tests'), 11:22:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:22:00 INFO - 'download_minidump_stackwalk': True, 11:22:00 INFO - 'download_symbols': 'ondemand', 11:22:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:22:00 INFO - 'tooltool.py': '/tools/tooltool.py', 11:22:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:22:00 INFO - '/tools/misc-python/virtualenv.py')}, 11:22:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:22:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:22:00 INFO - 'installer_path': 'installer.exe', 11:22:00 INFO - 'log_level': 'info', 11:22:00 INFO - 'log_name': 'talos', 11:22:00 INFO - 'log_to_console': True, 11:22:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:22:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:22:00 INFO - 'opt_config_files': (), 11:22:00 INFO - 'pip_index': False, 11:22:00 INFO - 'sps_profile': False, 11:22:00 INFO - 'sps_profile_interval': 0, 11:22:00 INFO - 'suite': 'dromaeojs-e10s', 11:22:00 INFO - 'system_bits': '32', 11:22:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:22:00 INFO - 'title': 'talos-linux64-ix-061', 11:22:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:22:00 INFO - 'use_talos_json': True, 11:22:00 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 11:22:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:22:00 INFO - 'work_dir': 'build'} 11:22:00 INFO - ##### 11:22:00 INFO - ##### Running clobber step. 11:22:00 INFO - ##### 11:22:00 INFO - Running pre-action listener: _resource_record_pre_action 11:22:00 INFO - Running main action method: clobber 11:22:00 INFO - rmtree: /builds/slave/test-pgo/build 11:22:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 11:22:01 INFO - Running post-action listener: _resource_record_post_action 11:22:01 INFO - ##### 11:22:01 INFO - ##### Running read-buildbot-config 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: read_buildbot_config 11:22:01 INFO - Using buildbot properties: 11:22:01 INFO - { 11:22:01 INFO - "properties": { 11:22:01 INFO - "buildnumber": 16, 11:22:01 INFO - "product": "firefox", 11:22:01 INFO - "script_repo_revision": "production", 11:22:01 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 11:22:01 INFO - "repository": "", 11:22:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 11:22:01 INFO - "buildid": "20160125032407", 11:22:01 INFO - "slavename": "talos-linux64-ix-061", 11:22:01 INFO - "pgo_build": "True", 11:22:01 INFO - "basedir": "/builds/slave/test-pgo", 11:22:01 INFO - "project": "", 11:22:01 INFO - "platform": "ubuntu64_hw", 11:22:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:22:01 INFO - "slavebuilddir": "test", 11:22:01 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 11:22:01 INFO - "branch": "mozilla-aurora", 11:22:01 INFO - "repo_path": "releases/mozilla-aurora", 11:22:01 INFO - "stage_platform": "linux64-pgo", 11:22:01 INFO - "builduid": "84a569e400f549d78ae6c3dedf0c2ad7", 11:22:01 INFO - "revision": "3bfa5bc61b626761d487b45c170b115259f69d6b" 11:22:01 INFO - }, 11:22:01 INFO - "sourcestamp": { 11:22:01 INFO - "repository": "", 11:22:01 INFO - "hasPatch": false, 11:22:01 INFO - "project": "", 11:22:01 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 11:22:01 INFO - "changes": [ 11:22:01 INFO - { 11:22:01 INFO - "category": null, 11:22:01 INFO - "files": [ 11:22:01 INFO - { 11:22:01 INFO - "url": null, 11:22:01 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:01 INFO - } 11:22:01 INFO - ], 11:22:01 INFO - "repository": "", 11:22:01 INFO - "rev": "3bfa5bc61b626761d487b45c170b115259f69d6b", 11:22:01 INFO - "who": "cbook@mozilla.com", 11:22:01 INFO - "when": 1453730728, 11:22:01 INFO - "number": 7510949, 11:22:01 INFO - "comments": "Bug 1234675 - Ability to disable e10s for users with addons. r=Mossop, a=sylvestre", 11:22:01 INFO - "project": "", 11:22:01 INFO - "at": "Mon 25 Jan 2016 06:05:28", 11:22:01 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 11:22:01 INFO - "revlink": "", 11:22:01 INFO - "properties": [ 11:22:01 INFO - [ 11:22:01 INFO - "buildid", 11:22:01 INFO - "20160125032407", 11:22:01 INFO - "Change" 11:22:01 INFO - ], 11:22:01 INFO - [ 11:22:01 INFO - "builduid", 11:22:01 INFO - "84a569e400f549d78ae6c3dedf0c2ad7", 11:22:01 INFO - "Change" 11:22:01 INFO - ], 11:22:01 INFO - [ 11:22:01 INFO - "pgo_build", 11:22:01 INFO - "True", 11:22:01 INFO - "Change" 11:22:01 INFO - ] 11:22:01 INFO - ], 11:22:01 INFO - "revision": "3bfa5bc61b626761d487b45c170b115259f69d6b" 11:22:01 INFO - } 11:22:01 INFO - ], 11:22:01 INFO - "revision": "3bfa5bc61b626761d487b45c170b115259f69d6b" 11:22:01 INFO - } 11:22:01 INFO - } 11:22:01 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:01 INFO - Running post-action listener: _resource_record_post_action 11:22:01 INFO - ##### 11:22:01 INFO - ##### Running download-and-extract 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: download_and_extract 11:22:01 INFO - mkdir: /builds/slave/test-pgo/build/tests 11:22:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:01 INFO - https://queue.taskcluster.net/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:22:01 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:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/test_packages.json 11:22:01 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:01 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:02 INFO - Downloaded 1302 bytes. 11:22:02 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 11:22:02 INFO - Using the following test package requirements: 11:22:02 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 11:22:02 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:22:02 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 11:22:02 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:22:02 INFO - u'jsshell-linux-x86_64.zip'], 11:22:02 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:22:02 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 11:22:02 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 11:22:02 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:22:02 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 11:22:02 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:22:02 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 11:22:02 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:22:02 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 11:22:02 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 11:22:02 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:22:02 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 11:22:02 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 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/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 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/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:22:02 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:02 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:02 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:06 INFO - Downloaded 21579043 bytes. 11:22:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 11:22:06 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:22:06 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 11:22: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:11 INFO - Downloaded 11132038 bytes. 11:22:11 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:11 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 11:22:11 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:12 INFO - Return code: 0 11:22:12 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:12 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:12 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:12 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:12 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:12 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:14 INFO - Downloaded 58070235 bytes. 11:22:14 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:14 INFO - mkdir: /builds/slave/test-pgo/properties 11:22:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 11:22:14 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 11:22:14 INFO - Contents: 11:22:14 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:14 INFO - Running post-action listener: _resource_record_post_action 11:22:14 INFO - Running post-action listener: set_extra_try_arguments 11:22:14 INFO - ##### 11:22:14 INFO - ##### Running populate-webroot step. 11:22:14 INFO - ##### 11:22:14 INFO - Running pre-action listener: _resource_record_pre_action 11:22:14 INFO - Running main action method: populate_webroot 11:22:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:22:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:22:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:22:14 INFO - '--tppagecycles', 11:22:14 INFO - '7'], 11:22:14 INFO - 'tests': ['tsvgm']}}, 11:22:14 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:22:14 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:22:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:22:14 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:22:14 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:22:14 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:22:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:22:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:14 INFO - 'talos_options': ['--e10s'], 11:22:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:22:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:14 INFO - 'tests': ['damp', 'tps']}, 11:22:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:14 INFO - 'talos_options': ['--e10s'], 11:22:14 INFO - 'tests': ['damp', 'tps']}, 11:22:14 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:22:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:22:14 INFO - 'other': {'tests': ['a11yr', 11:22:14 INFO - 'ts_paint', 11:22:14 INFO - 'tpaint', 11:22:14 INFO - 'sessionrestore', 11:22:14 INFO - 'sessionrestore_no_auto_restore']}, 11:22:14 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:22:14 INFO - 'tests': ['a11yr', 11:22:14 INFO - 'ts_paint', 11:22:14 INFO - 'tpaint', 11:22:14 INFO - 'sessionrestore', 11:22:14 INFO - 'sessionrestore_no_auto_restore']}, 11:22:14 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:22:14 INFO - 'tests': ['a11yr', 11:22:14 INFO - 'ts_paint', 11:22:14 INFO - 'tpaint', 11:22:14 INFO - 'sessionrestore', 11:22:14 INFO - 'sessionrestore_no_auto_restore']}, 11:22:14 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:22:14 INFO - 'tests': ['a11yr', 11:22:14 INFO - 'ts_paint', 11:22:14 INFO - 'tpaint', 11:22:14 INFO - 'sessionrestore', 11:22:14 INFO - 'sessionrestore_no_auto_restore']}, 11:22:14 INFO - 'other_l64': {'tests': ['a11yr', 11:22:14 INFO - 'ts_paint', 11:22:14 INFO - 'tpaint', 11:22:14 INFO - 'sessionrestore', 11:22:14 INFO - 'sessionrestore_no_auto_restore']}, 11:22:14 INFO - 'other_nol64': {'tests': ['a11yr', 11:22:14 INFO - 'ts_paint', 11:22:14 INFO - 'tpaint', 11:22:14 INFO - 'sessionrestore', 11:22:14 INFO - 'sessionrestore_no_auto_restore']}, 11:22:14 INFO - 'svgr': {'tests': ['tsvgx', 11:22:14 INFO - 'tsvgr_opacity', 11:22:14 INFO - 'tart', 11:22:14 INFO - 'tscrollx', 11:22:14 INFO - 'cart']}, 11:22:14 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:22:14 INFO - 'tests': ['tsvgx', 11:22:14 INFO - 'tsvgr_opacity', 11:22:14 INFO - 'tart', 11:22:14 INFO - 'tscrollx', 11:22:14 INFO - 'cart']}, 11:22:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:14 INFO - 'tests': ['tp5o']}, 11:22:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:14 INFO - 'talos_options': ['--e10s'], 11:22:14 INFO - 'tests': ['tp5o']}, 11:22:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:14 INFO - 'talos_options': ['--xperf_path', 11:22:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:22:14 INFO - 'tests': ['tp5n']}, 11:22:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:14 INFO - 'talos_options': ['--e10s', 11:22:14 INFO - '--xperf_path', 11:22:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:22:14 INFO - 'tests': ['tp5n']}}, 11:22:14 INFO - 'talos.zip': {'path': '', 11:22:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:22:14 INFO - Running post-action listener: _resource_record_post_action 11:22:14 INFO - ##### 11:22:14 INFO - ##### Running create-virtualenv step. 11:22:14 INFO - ##### 11:22:14 INFO - Running pre-action listener: _resource_record_pre_action 11:22:14 INFO - Running main action method: create_virtualenv 11:22:14 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 11:22:14 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:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 11:22:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:22:14 INFO - Using real prefix '/usr' 11:22:14 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 11:22:14 INFO - Installing distribute.............................................................................................................................................................................................done. 11:22:16 INFO - Installing pip.................done. 11:22:16 INFO - Return code: 0 11:22:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 11:22:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:16 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb620db6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x158d500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158a6a0>, '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 0x158b5a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158ba30>, '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': '516f8d7ca085b4d087ab0a71000001a4-1453749718.621086-22118459', '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:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 11:22:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:22:16 INFO - Using env: {'DISPLAY': ':0', 11:22:16 INFO - 'HOME': '/home/cltbld', 11:22:16 INFO - 'LANG': 'en_US.UTF-8', 11:22:16 INFO - 'LANGUAGE': 'en_US:en', 11:22:16 INFO - 'LOGNAME': 'cltbld', 11:22:16 INFO - 'MAIL': '/var/mail/cltbld', 11:22:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:16 INFO - 'MOZ_NO_REMOTE': '1', 11:22:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:16 INFO - 'NO_EM_RESTART': '1', 11:22:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:22:16 INFO - 'PWD': '/builds/slave/test-pgo', 11:22:16 INFO - 'SHELL': '/bin/bash', 11:22:16 INFO - 'SHLVL': '1', 11:22:16 INFO - 'TERM': 'linux', 11:22:16 INFO - 'TMOUT': '86400', 11:22:16 INFO - 'USER': 'cltbld', 11:22:16 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1453749718.621086-22118459', 11:22:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:16 INFO - '_': '/tools/buildbot/bin/python'} 11:22:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:16 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:16 INFO - Cleaning up... 11:22:16 INFO - Return code: 0 11:22:16 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 11:22:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:16 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb620db6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x158d500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158a6a0>, '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 0x158b5a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158ba30>, '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': '516f8d7ca085b4d087ab0a71000001a4-1453749718.621086-22118459', '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:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 11:22:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 11:22:16 INFO - Using env: {'DISPLAY': ':0', 11:22:16 INFO - 'HOME': '/home/cltbld', 11:22:16 INFO - 'LANG': 'en_US.UTF-8', 11:22:16 INFO - 'LANGUAGE': 'en_US:en', 11:22:16 INFO - 'LOGNAME': 'cltbld', 11:22:16 INFO - 'MAIL': '/var/mail/cltbld', 11:22:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:16 INFO - 'MOZ_NO_REMOTE': '1', 11:22:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:16 INFO - 'NO_EM_RESTART': '1', 11:22:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:22:16 INFO - 'PWD': '/builds/slave/test-pgo', 11:22:16 INFO - 'SHELL': '/bin/bash', 11:22:16 INFO - 'SHLVL': '1', 11:22:16 INFO - 'TERM': 'linux', 11:22:16 INFO - 'TMOUT': '86400', 11:22:16 INFO - 'USER': 'cltbld', 11:22:16 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1453749718.621086-22118459', 11:22:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:16 INFO - '_': '/tools/buildbot/bin/python'} 11:22:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:17 INFO - Downloading/unpacking psutil>=0.7.1 11:22:17 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:17 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:17 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:17 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:17 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:17 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:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 11:22:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:22:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:22:18 INFO - Installing collected packages: psutil 11:22:18 INFO - Running setup.py install for psutil 11:22:18 INFO - building 'psutil._psutil_linux' extension 11:22:18 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:19 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:19 INFO - building 'psutil._psutil_posix' extension 11:22:19 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:19 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:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:22:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:22:19 INFO - Successfully installed psutil 11:22:19 INFO - Cleaning up... 11:22:19 INFO - Return code: 0 11:22:19 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 11:22:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:19 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb620db6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x158d500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158a6a0>, '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 0x158b5a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158ba30>, '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': '516f8d7ca085b4d087ab0a71000001a4-1453749718.621086-22118459', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:22:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 11:22:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 11:22:19 INFO - Using env: {'DISPLAY': ':0', 11:22:19 INFO - 'HOME': '/home/cltbld', 11:22:19 INFO - 'LANG': 'en_US.UTF-8', 11:22:19 INFO - 'LANGUAGE': 'en_US:en', 11:22:19 INFO - 'LOGNAME': 'cltbld', 11:22:19 INFO - 'MAIL': '/var/mail/cltbld', 11:22:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:19 INFO - 'MOZ_NO_REMOTE': '1', 11:22:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:19 INFO - 'NO_EM_RESTART': '1', 11:22:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:22:19 INFO - 'PWD': '/builds/slave/test-pgo', 11:22:19 INFO - 'SHELL': '/bin/bash', 11:22:19 INFO - 'SHLVL': '1', 11:22:19 INFO - 'TERM': 'linux', 11:22:19 INFO - 'TMOUT': '86400', 11:22:19 INFO - 'USER': 'cltbld', 11:22:19 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1453749718.621086-22118459', 11:22:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:19 INFO - '_': '/tools/buildbot/bin/python'} 11:22:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:19 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 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:21 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:22:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:22:21 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:21 INFO - Installing collected packages: mozsystemmonitor 11:22:21 INFO - Running setup.py install for mozsystemmonitor 11:22:21 INFO - Successfully installed mozsystemmonitor 11:22:21 INFO - Cleaning up... 11:22:21 INFO - Return code: 0 11:22:21 INFO - Installing blobuploader==1.2.4 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', '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 0x7fb620db6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x158d500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158a6a0>, '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 0x158b5a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158ba30>, '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': '516f8d7ca085b4d087ab0a71000001a4-1453749718.621086-22118459', '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', 'blobuploader==1.2.4'] 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 blobuploader==1.2.4 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': '516f8d7ca085b4d087ab0a71000001a4-1453749718.621086-22118459', 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 blobuploader==1.2.4 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 blobuploader-1.2.4.tar.gz 11:22:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:22:23 INFO - Downloading/unpacking requests==1.2.3. (from 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:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 11:22:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:22:24 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:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:24 INFO - 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:24 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:24 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:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:24 INFO - Downloading docopt-0.6.1.tar.gz 11:22:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 11:22:24 INFO - Installing collected packages: blobuploader, requests, docopt 11:22:24 INFO - Running setup.py install for blobuploader 11:22:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:22:24 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 11:22:24 INFO - Running setup.py install for requests 11:22:24 INFO - Running setup.py install for docopt 11:22:24 INFO - Successfully installed blobuploader requests docopt 11:22:24 INFO - Cleaning up... 11:22:24 INFO - Return code: 0 11:22:24 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:22:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:24 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fb620db6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x158d500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158a6a0>, '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 0x158b5a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158ba30>, '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': '516f8d7ca085b4d087ab0a71000001a4-1453749718.621086-22118459', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:22:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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:24 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:24 INFO - Using env: {'DISPLAY': ':0', 11:22:24 INFO - 'HOME': '/home/cltbld', 11:22:24 INFO - 'LANG': 'en_US.UTF-8', 11:22:24 INFO - 'LANGUAGE': 'en_US:en', 11:22:24 INFO - 'LOGNAME': 'cltbld', 11:22:24 INFO - 'MAIL': '/var/mail/cltbld', 11:22:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:24 INFO - 'MOZ_NO_REMOTE': '1', 11:22:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:24 INFO - 'NO_EM_RESTART': '1', 11:22:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:22:24 INFO - 'PWD': '/builds/slave/test-pgo', 11:22:24 INFO - 'SHELL': '/bin/bash', 11:22:24 INFO - 'SHLVL': '1', 11:22:24 INFO - 'TERM': 'linux', 11:22:24 INFO - 'TMOUT': '86400', 11:22:24 INFO - 'USER': 'cltbld', 11:22:24 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1453749718.621086-22118459', 11:22:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:24 INFO - '_': '/tools/buildbot/bin/python'} 11:22:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:22:25 INFO - Running setup.py (path:/tmp/pip-hbph7c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:22:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:22:25 INFO - Running setup.py (path:/tmp/pip-XGV6Wy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:22:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:22:25 INFO - Running setup.py (path:/tmp/pip-sU89Nl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:22:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:22:25 INFO - Running setup.py (path:/tmp/pip-3fwqZX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:22:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:22:25 INFO - Running setup.py (path:/tmp/pip-Th_kk9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:22:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:22:25 INFO - Running setup.py (path:/tmp/pip-OJMh0K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:22:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:22:25 INFO - Running setup.py (path:/tmp/pip-2nE0pr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:22:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:22:25 INFO - Running setup.py (path:/tmp/pip-G2Khg4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:22:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:22:25 INFO - Running setup.py (path:/tmp/pip-aeqH60-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:22:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:22:25 INFO - Running setup.py (path:/tmp/pip-fvxrdA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:22:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:22:25 INFO - Running setup.py (path:/tmp/pip-4dUXmo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:22:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:22:25 INFO - Running setup.py (path:/tmp/pip-k_xN5w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:22:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:22:26 INFO - Running setup.py (path:/tmp/pip-CjLDoQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:22:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:22:26 INFO - Running setup.py (path:/tmp/pip-UAp_xv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:22:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:22:26 INFO - Running setup.py (path:/tmp/pip-plnrtg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:22:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:22:26 INFO - Running setup.py (path:/tmp/pip-4fH2y8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:22:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:22:26 INFO - Running setup.py (path:/tmp/pip-bwYc2n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:22:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:22:26 INFO - Running setup.py install for manifestparser 11:22:26 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 11:22:26 INFO - Running setup.py install for mozcrash 11:22:26 INFO - Running setup.py install for mozdebug 11:22:26 INFO - Running setup.py install for mozdevice 11:22:26 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 11:22:26 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 11:22:26 INFO - Running setup.py install for mozfile 11:22:26 INFO - Running setup.py install for mozhttpd 11:22:26 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 11:22:26 INFO - Running setup.py install for mozinfo 11:22:27 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 11:22:27 INFO - Running setup.py install for mozInstall 11:22:27 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 11:22:27 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 11:22:27 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 11:22:27 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 11:22:27 INFO - Running setup.py install for mozleak 11:22:27 INFO - Running setup.py install for mozlog 11:22:27 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 11:22:27 INFO - Running setup.py install for moznetwork 11:22:27 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 11:22:27 INFO - Running setup.py install for mozprocess 11:22:27 INFO - Running setup.py install for mozprofile 11:22:27 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 11:22:27 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 11:22:27 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 11:22:27 INFO - Running setup.py install for mozrunner 11:22:27 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 11:22:27 INFO - Running setup.py install for mozscreenshot 11:22:27 INFO - Running setup.py install for moztest 11:22:28 INFO - Running setup.py install for mozversion 11:22:28 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 11:22:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:22:28 INFO - Cleaning up... 11:22:28 INFO - Return code: 0 11:22:28 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:22:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:28 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fb620db6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x158d500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158a6a0>, '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 0x158b5a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158ba30>, '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': '516f8d7ca085b4d087ab0a71000001a4-1453749718.621086-22118459', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:22:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 11:22:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:22:28 INFO - Using env: {'DISPLAY': ':0', 11:22:28 INFO - 'HOME': '/home/cltbld', 11:22:28 INFO - 'LANG': 'en_US.UTF-8', 11:22:28 INFO - 'LANGUAGE': 'en_US:en', 11:22:28 INFO - 'LOGNAME': 'cltbld', 11:22:28 INFO - 'MAIL': '/var/mail/cltbld', 11:22:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:28 INFO - 'MOZ_NO_REMOTE': '1', 11:22:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:28 INFO - 'NO_EM_RESTART': '1', 11:22:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:22:28 INFO - 'PWD': '/builds/slave/test-pgo', 11:22:28 INFO - 'SHELL': '/bin/bash', 11:22:28 INFO - 'SHLVL': '1', 11:22:28 INFO - 'TERM': 'linux', 11:22:28 INFO - 'TMOUT': '86400', 11:22:28 INFO - 'USER': 'cltbld', 11:22:28 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1453749718.621086-22118459', 11:22:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:28 INFO - '_': '/tools/buildbot/bin/python'} 11:22:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:22:28 INFO - Running setup.py (path:/tmp/pip-Ye_1bt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:22:28 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:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:22:28 INFO - Running setup.py (path:/tmp/pip-gzAEmY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:22:28 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:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:22:28 INFO - Running setup.py (path:/tmp/pip-kSnyvy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:22:28 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:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:22:28 INFO - Running setup.py (path:/tmp/pip-_7v8ix-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:22:28 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:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:22:28 INFO - Running setup.py (path:/tmp/pip-oKS7GI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:22:28 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:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:22:28 INFO - Running setup.py (path:/tmp/pip-sLZtPe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:22:28 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:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:22:28 INFO - Running setup.py (path:/tmp/pip-sVOnbb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:22:28 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:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:22:28 INFO - Running setup.py (path:/tmp/pip-9qJxd0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:22:28 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:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:22:28 INFO - Running setup.py (path:/tmp/pip-y0I2LD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:22:29 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:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:22:29 INFO - Running setup.py (path:/tmp/pip-cPlYDR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:22:29 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:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:22:29 INFO - Running setup.py (path:/tmp/pip-VzMGNI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:22:29 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:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:22:29 INFO - Running setup.py (path:/tmp/pip-yDZPG2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:22:29 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:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:22:29 INFO - Running setup.py (path:/tmp/pip-AOreyy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:22:29 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:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:22:29 INFO - Running setup.py (path:/tmp/pip-wbX9MW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:22:29 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:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:22:29 INFO - Running setup.py (path:/tmp/pip-w60g5J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:22:29 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:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:22:29 INFO - Running setup.py (path:/tmp/pip-NfHZbP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:22:29 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:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:22:29 INFO - Running setup.py (path:/tmp/pip-IkBHdw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:22:29 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:29 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:29 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:29 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:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 11:22:29 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:29 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:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:31 INFO - Downloading blessings-1.6.tar.gz 11:22:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 11:22:31 INFO - Installing collected packages: blessings 11:22:31 INFO - Running setup.py install for blessings 11:22:31 INFO - Successfully installed blessings 11:22:31 INFO - Cleaning up... 11:22:31 INFO - Return code: 0 11:22:31 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 11:22:31 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:22:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:22:31 INFO - Reading from file tmpfile_stdout 11:22:31 INFO - Current package versions: 11:22:31 INFO - argparse == 1.2.1 11:22:31 INFO - blessings == 1.6 11:22:31 INFO - blobuploader == 1.2.4 11:22:31 INFO - docopt == 0.6.1 11:22:31 INFO - manifestparser == 1.1 11:22:31 INFO - mozInstall == 1.12 11:22:31 INFO - mozcrash == 0.16 11:22:31 INFO - mozdebug == 0.1 11:22:31 INFO - mozdevice == 0.47 11:22:31 INFO - mozfile == 1.2 11:22:31 INFO - mozhttpd == 0.7 11:22:31 INFO - mozinfo == 0.9 11:22:31 INFO - mozleak == 0.1 11:22:31 INFO - mozlog == 3.1 11:22:31 INFO - moznetwork == 0.27 11:22:31 INFO - mozprocess == 0.22 11:22:31 INFO - mozprofile == 0.27 11:22:31 INFO - mozrunner == 6.11 11:22:31 INFO - mozscreenshot == 0.1 11:22:31 INFO - mozsystemmonitor == 0.0 11:22:31 INFO - moztest == 0.7 11:22:31 INFO - mozversion == 1.4 11:22:31 INFO - psutil == 3.1.1 11:22:31 INFO - requests == 1.2.3 11:22:31 INFO - wsgiref == 0.1.2 11:22:31 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:22:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:31 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7fb620db6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x158d500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158a6a0>, '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 0x158b5a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158ba30>, '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': '516f8d7ca085b4d087ab0a71000001a4-1453749718.621086-22118459', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:22:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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:31 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:31 INFO - Using env: {'DISPLAY': ':0', 11:22:31 INFO - 'HOME': '/home/cltbld', 11:22:31 INFO - 'LANG': 'en_US.UTF-8', 11:22:31 INFO - 'LANGUAGE': 'en_US:en', 11:22:31 INFO - 'LOGNAME': 'cltbld', 11:22:31 INFO - 'MAIL': '/var/mail/cltbld', 11:22:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:31 INFO - 'MOZ_NO_REMOTE': '1', 11:22:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:31 INFO - 'NO_EM_RESTART': '1', 11:22:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:22:31 INFO - 'PWD': '/builds/slave/test-pgo', 11:22:31 INFO - 'SHELL': '/bin/bash', 11:22:31 INFO - 'SHLVL': '1', 11:22:31 INFO - 'TERM': 'linux', 11:22:31 INFO - 'TMOUT': '86400', 11:22:31 INFO - 'USER': 'cltbld', 11:22:31 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1453749718.621086-22118459', 11:22:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:31 INFO - '_': '/tools/buildbot/bin/python'} 11:22:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:32 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:32 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:32 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:32 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:32 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:32 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:32 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:32 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:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 11:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 11:22:32 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:32 INFO - Cleaning up... 11:22:32 INFO - Return code: 0 11:22:32 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 11:22:32 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:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:32 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:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:32 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 0x7fb620db6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x158d500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158a6a0>, '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 0x158b5a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158ba30>, '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': '516f8d7ca085b4d087ab0a71000001a4-1453749718.621086-22118459', '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:32 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:32 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:32 INFO - Using env: {'DISPLAY': ':0', 11:22:32 INFO - 'HOME': '/home/cltbld', 11:22:32 INFO - 'LANG': 'en_US.UTF-8', 11:22:32 INFO - 'LANGUAGE': 'en_US:en', 11:22:32 INFO - 'LOGNAME': 'cltbld', 11:22:32 INFO - 'MAIL': '/var/mail/cltbld', 11:22:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:32 INFO - 'MOZ_NO_REMOTE': '1', 11:22:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:32 INFO - 'NO_EM_RESTART': '1', 11:22:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:22:32 INFO - 'PWD': '/builds/slave/test-pgo', 11:22:32 INFO - 'SHELL': '/bin/bash', 11:22:32 INFO - 'SHLVL': '1', 11:22:32 INFO - 'TERM': 'linux', 11:22:32 INFO - 'TMOUT': '86400', 11:22:32 INFO - 'USER': 'cltbld', 11:22:32 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1453749718.621086-22118459', 11:22:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:32 INFO - '_': '/tools/buildbot/bin/python'} 11:22:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:32 INFO - Downloading/unpacking jsonschema 11:22:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:22:34 INFO - Downloading/unpacking functools32 (from 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:34 INFO - Downloading functools32-3.2.3-2.tar.gz 11:22:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 11:22:34 INFO - warning: no files found matching '*.txt' 11:22:34 INFO - no previously-included directories found matching 'build' 11:22:34 INFO - no previously-included directories found matching 'dist' 11:22:34 INFO - no previously-included directories found matching '.git*' 11:22:34 INFO - Installing collected packages: jsonschema, functools32 11:22:34 INFO - Running setup.py install for functools32 11:22:34 INFO - warning: no files found matching '*.txt' 11:22:34 INFO - no previously-included directories found matching 'build' 11:22:34 INFO - no previously-included directories found matching 'dist' 11:22:34 INFO - no previously-included directories found matching '.git*' 11:22:34 INFO - Successfully installed jsonschema functools32 11:22:34 INFO - Cleaning up... 11:22:34 INFO - Return code: 0 11:22:34 INFO - Installing flake8 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb620db6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x158d500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158a6a0>, '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 0x158b5a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158ba30>, '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': '516f8d7ca085b4d087ab0a71000001a4-1453749718.621086-22118459', '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', 'flake8'] 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 flake8 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': '516f8d7ca085b4d087ab0a71000001a4-1453749718.621086-22118459', 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 flake8 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 flake8-2.5.0-py2.py3-none-any.whl 11:22:36 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from 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:36 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:22:36 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from 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:36 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from 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:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 11:22:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:22:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:22:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:22:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:22:37 INFO - no previously-included directories found matching 'docs/_build' 11:22:37 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:22:37 INFO - Running setup.py install for pep8 11:22:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:22:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:22:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:22:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:22:37 INFO - no previously-included directories found matching 'docs/_build' 11:22:37 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 11:22:37 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:22:37 INFO - Cleaning up... 11:22:37 INFO - Return code: 0 11:22:37 INFO - Running post-action listener: _resource_record_post_action 11:22:37 INFO - Running post-action listener: _start_resource_monitoring 11:22:37 INFO - Starting resource monitoring. 11:22:37 INFO - ##### 11:22:37 INFO - ##### Running install step. 11:22:37 INFO - ##### 11:22:37 INFO - Running pre-action listener: _resource_record_pre_action 11:22:37 INFO - Running main action method: install 11:22:37 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:22:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:22:37 INFO - Reading from file tmpfile_stdout 11:22:37 INFO - Detecting whether we're running mozinstall >=1.0... 11:22:37 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 11:22:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 11:22:37 INFO - Reading from file tmpfile_stdout 11:22:37 INFO - Output received: 11:22:37 INFO - Usage: mozinstall [options] installer 11:22:37 INFO - Options: 11:22:37 INFO - -h, --help show this help message and exit 11:22:37 INFO - -d DEST, --destination=DEST 11:22:37 INFO - Directory to install application into. [default: 11:22:37 INFO - "/builds/slave/test-pgo"] 11:22:37 INFO - --app=APP Application being installed. [default: firefox] 11:22:37 INFO - mkdir: /builds/slave/test-pgo/build/application 11:22:37 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:37 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:52 INFO - Reading from file tmpfile_stdout 11:22:52 INFO - Output received: 11:22:52 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 11:22:52 INFO - Running post-action listener: _resource_record_post_action 11:22:52 INFO - ##### 11:22:52 INFO - ##### Running run-tests step. 11:22:52 INFO - ##### 11:22:52 INFO - Running pre-action listener: _resource_record_pre_action 11:22:52 INFO - Running main action method: run_tests 11:22:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 11:22:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 11:22:52 INFO - Python 2.7.3 11:22:52 INFO - Return code: 0 11:22:52 INFO - grabbing minidump binary from tooltool 11:22:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:52 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 0x158a6a0>, '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 0x158b5a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158ba30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 11:22:52 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:52 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:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:22:52 INFO - Return code: 0 11:22:52 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 11:22:52 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 11:22:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 11:22:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 11:22:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 11:22:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 11:22:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 11:22:53 INFO - Return code: 0 11:22:53 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-061', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 11:22:53 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-061 --webServer localhost 11:22:53 INFO - Using env: {'DISPLAY': ':0', 11:22:53 INFO - 'HOME': '/home/cltbld', 11:22:53 INFO - 'LANG': 'en_US.UTF-8', 11:22:53 INFO - 'LANGUAGE': 'en_US:en', 11:22:53 INFO - 'LOGNAME': 'cltbld', 11:22:53 INFO - 'MAIL': '/var/mail/cltbld', 11:22:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:22:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 11:22:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:53 INFO - 'MOZ_NO_REMOTE': '1', 11:22:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:22:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:53 INFO - 'NO_EM_RESTART': '1', 11:22:53 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:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:22:53 INFO - 'PWD': '/builds/slave/test-pgo', 11:22:53 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 11:22:53 INFO - 'SHELL': '/bin/bash', 11:22:53 INFO - 'SHLVL': '1', 11:22:53 INFO - 'TERM': 'linux', 11:22:53 INFO - 'TMOUT': '86400', 11:22:53 INFO - 'USER': 'cltbld', 11:22:53 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1453749718.621086-22118459', 11:22:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:53 INFO - '_': '/tools/buildbot/bin/python'} 11:22:53 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-061', '--webServer', 'localhost'] with output_timeout 3600 11:22:53 INFO - mozversion INFO | application_buildid: 20160125032407 11:22:53 INFO - mozversion INFO | application_changeset: 3bfa5bc61b626761d487b45c170b115259f69d6b 11:22:53 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 11:22:53 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:22:53 INFO - mozversion INFO | application_name: Firefox 11:22:53 INFO - mozversion INFO | application_remotingname: firefox-dev 11:22:53 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:22:53 INFO - mozversion INFO | application_vendor: Mozilla 11:22:53 INFO - mozversion INFO | application_version: 45.0a2 11:22:53 INFO - mozversion INFO | platform_buildid: 20160125032407 11:22:53 INFO - mozversion INFO | platform_changeset: 3bfa5bc61b626761d487b45c170b115259f69d6b 11:22:53 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:22:53 INFO - mozversion INFO | platform_version: 45.0a2 11:22:53 INFO - 2016-01-25 11:22:53,695 DEBUG : using testdate: 1453749773 11:22:53 INFO - 2016-01-25 11:22:53,695 DEBUG : actual date: 1453749773 11:22:53 INFO - 2016-01-25 11:22:53,703 INFO : starting webserver on 'localhost:60771' 11:22:53 INFO - 2016-01-25 11:22:53,704 INFO : Starting test suite talos-linux64-ix-061.e 11:22:53 INFO - 2016-01-25 11:22:53,704 INFO : Starting test dromaeo_css 11:22:53 INFO - 2016-01-25 11:22:53,704 DEBUG : operating with platform_type : linux_ 11:22:53 INFO - 2016-01-25 11:22:53,705 INFO : Initialising browser for dromaeo_css test... 11:22:53 INFO - 2016-01-25 11:22:53,720 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphRAsGy/profile http://localhost:60771/getInfo.html 11:22:57 INFO - 2016-01-25 11:22:57,163 DEBUG : BROWSER_OUTPUT: 11:22:57 INFO - 2016-01-25 11:22:57,163 DEBUG : BROWSER_OUTPUT: (process:25773): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:22:57 INFO - 2016-01-25 11:22:57,965 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:22:57 INFO - 2016-01-25 11:22:57,965 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:22:57 INFO - 2016-01-25 11:22:57,965 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:22:57 INFO - 2016-01-25 11:22:57,965 DEBUG : BROWSER_OUTPUT: __metrics 11:22:58 INFO - 2016-01-25 11:22:58,944 INFO : Browser initialized. 11:22:58 INFO - 2016-01-25 11:22:58,944 INFO : Running cycle 1/1 for dromaeo_css test... 11:22:58 INFO - 2016-01-25 11:22:58,945 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphRAsGy/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:23:00 INFO - 2016-01-25 11:23:00,201 DEBUG : BROWSER_OUTPUT: 11:23:00 INFO - 2016-01-25 11:23:00,201 DEBUG : BROWSER_OUTPUT: (process:25884): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:23:10 INFO - 2016-01-25 11:23:10,702 DEBUG : BROWSER_OUTPUT: RSS: Main: 138321920 11:23:10 INFO - 2016-01-25 11:23:10,702 DEBUG : BROWSER_OUTPUT: 11:24:00 INFO - 2016-01-25 11:24:00,318 DEBUG : BROWSER_OUTPUT: 1453749840318 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:08 INFO - 2016-01-25 11:26:08,445 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60771/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60771/tests/dromaeo/cssquery-ext.html) 11:26:09 INFO - 2016-01-25 11:26:09,474 DEBUG : BROWSER_OUTPUT: RSS: Main: 142893056 11:26:09 INFO - 2016-01-25 11:26:09,474 DEBUG : BROWSER_OUTPUT: 11:29:11 INFO - 2016-01-25 11:29:11,314 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60771/tests/dromaeo/cssquery-ext.html (next: http://localhost:60771/tests/dromaeo/cssquery-jquery.html) 11:29:11 INFO - 2016-01-25 11:29:11,916 DEBUG : BROWSER_OUTPUT: RSS: Main: 140181504 11:29:11 INFO - 2016-01-25 11:29:11,916 DEBUG : BROWSER_OUTPUT: 11:32:13 INFO - 2016-01-25 11:32:13,436 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60771/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60771/tests/dromaeo/cssquery-mootools.html) 11:32:14 INFO - 2016-01-25 11:32:14,022 DEBUG : BROWSER_OUTPUT: RSS: Main: 139096064 11:32:14 INFO - 2016-01-25 11:32:14,022 DEBUG : BROWSER_OUTPUT: 11:35:15 INFO - 2016-01-25 11:35:15,638 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60771/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60771/tests/dromaeo/cssquery-prototype.html) 11:35:16 INFO - 2016-01-25 11:35:16,224 DEBUG : BROWSER_OUTPUT: RSS: Main: 139702272 11:35:16 INFO - 2016-01-25 11:35:16,224 DEBUG : BROWSER_OUTPUT: 11:38:18 INFO - 2016-01-25 11:38:18,447 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60771/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60771/tests/dromaeo/cssquery-yui.html) 11:38:19 INFO - 2016-01-25 11:38:19,035 DEBUG : BROWSER_OUTPUT: RSS: Main: 140087296 11:38:19 INFO - 2016-01-25 11:38:19,035 DEBUG : BROWSER_OUTPUT: 11:41:20 INFO - 2016-01-25 11:41:20,995 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60771/tests/dromaeo/cssquery-yui.html (next: http://localhost:60771/tests/dromaeo/cssquery-dojo.html) 11:41:21 INFO - 2016-01-25 11:41:21,245 DEBUG : BROWSER_OUTPUT: RSS: Main: 141873152 11:41:21 INFO - 2016-01-25 11:41:21,245 DEBUG : BROWSER_OUTPUT: 11:41:21 INFO - 2016-01-25 11:41:21,245 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:41:21 INFO - 2016-01-25 11:41:21,245 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:41:21 INFO - 2016-01-25 11:41:21,245 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:41:21 INFO - 2016-01-25 11:41:21,246 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:41:21 INFO - 2016-01-25 11:41:21,247 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3233.9191520211994;3271.6401195868466;3281.442154833678;3299.2411745298573;3301.9834900825495;5409.13453847384;5429.294191755072;5443.374011988622;5444.346678398598;5458.918116228259;5515.531179849718;5538.861528461791;5545.3622833374175;5557.3331200256025;5584.664920104797;4962.65261431699;5034.521720436553;5049.4950504949575;5110.744462776846;5131.589472842183;4825.155597770394;4987.351644286256;4994.825181118662;5006.224035274538;5080.339555857752;4977.800887964477;5080.441151473354;5080.441151473354;5093.032323858473;5166.17341225404;5097.108006098936;5128.666636668605;5129.1024070787835;5135.050015747099;5153.587712982971;4853.781579828917;4888.9755551222015;4950.777215025297;5041.873953151164;5059.2916991621205;5365.356157261114;5369.463053694639;5420.376656684492;5441.537469315073;5449.155380915964;5920.674362910038;5978.641281523079;6004.129401236796;6027.819165425044;6028.156058151862;5794.5074668653215;5896.174535565025;5928.555358348098;5976.103584462322;6067;5596.468335508161;5602.859928501779;5605.355384130837;5626.437356264381;5637.436256374371;6087.482563982023;6101.206843110367;6102.633841969496;6105.053716673922;6109.908351374733;5606.6916319602815;5693.829185124453;5709.486146246774;5782.45066718661;5832.912506312408;5950.702464876739;5966.985612445895;5975.25309336333;5976.970115149484;5997.490213331828;5899.321578018497;5925.911111333334;5930.1994230779155;5939.2575928009;5954.225950626477;5678.716064196774;5748.9712551437815;5857.121431785266;5965.254343207099;5980.461758441761;4577.382053422745;4585.70192937458;4591.632669386441;4593.770311484413;4612.262038073959;3962.8612998544913;4099.344104943195;4109.547949725527;4115.444415003936;4121.155163191538;5576.581756368289;5594.1888426177975;5635.633683810539;5709.143628455765;5727.140928860621;5951.196588460589;5981.850453738692;6006.609570377911;6026.5178785697035;6039.335673075958;5380.2736630555155;5486.177073439016;5582.302212223472;5618.213450116987;5664.745086471119;5094.006668699568;5181.974090129601;5189.117849965515;5196.662216955886;5199.532042116228;6184.134221209034;6206.348333425016;6211.3167551569295;6224.439800417984;6228.844278893064;5758.165066065313;5820.82537523858;5878.823635290948;6067.180930574316;6071.301800293023;6081.969590152198;6127.6936153193055;6137.101203255387;6141.117811339906;6144.402455361549;5903.822885313448;5959.344472107978;5968.462838344396;5969.3732158122775;6007.519398448201;5751.798687045934;5856.12158176277;6048.183495228088;6049.3950604939155;6079.3008803988105;5719.771209151588;5763.9135412968;5774.509166720875;5793.420657934173;5821.301443826768;5897;5900.911486327623;5903.940960590511;5904.439078287556;5932.466078052996;5603.131514615241;5644.717764111696;5681.630694004876;5712.11462223356;5761.827145185651;5901.7639294427745;5921.792737254175;5929.466348028698;5942.286925568959;5970.164177015308;5708.57185711065;5785.652860828363;5812.157237200498;5827.24245848037;5832.183494310885 11:41:21 INFO - 2016-01-25 11:41:21,248 DEBUG : BROWSER_OUTPUT: |1;ext.html;590.8611476303068;632.5635311634973;637.2830565613683;639.8144538083956;699.9675478668964;31985.200369990762;40409.59590404095;40413.393799093;40465;40517.594824051754;43134.13731725363;43826.12347753043;43848.780756096174;43857.34213986793;43898.78050609751;8990.640374385017;9061.50161741104;9146.817063658722;9153.67962121326;9167.174954254117;8665.566721663923;8794.252488538483;8807.867881981776;8830.514321712304;8841.778955526132;8937.687180948667;8939.329550283723;8952.8657070144;8987.191152796247;9029.187373136416;8935.329850261223;8980.236679882251;9009.954950225207;9036.593353299051;9049.140331668514;8859.778505537348;8936.955315223382;9002.369834111614;9009.909900900973;9026.413283136575;40754.796226018974;40800.795996020126;40979.7951010246;41032.38451423231;41253.381199282034;3645.8177091145335;3675.4119340905595;3684.6315368463206;3789.7347185697013;4067.613576710208;34357.312853742784;34393.484097738554;34450.483242751376;34803.477947830805;34953.300933981176;3579.355715971124;3589.623324069037;3613.3134704406343;3721.0325315418186;3725.0873535983587;299738;302646;302996;303164;304352;48516.51483485191;48810.26784598234;69754;70895.64552177206;70947.2905270951;64836.351636483974;65237.021444678365;65268;65338.673306633165;65380.34619653742;16439.178041098137;16591.668166636842;16624.25190866414;16680.916595416944;16695.415660451825;12610.49558017669;12657.683557910941;12783.23300601967;12877.678058048436;12996.935015324863;21626.243081492074;21846.344609661737;21893.781062189493;21895.452613684785;21970.560588788456;8613.181747733955;8674.306055515544;8697.521636310064;8717.782055448664;8787.428817126995;946.2335508238349;1035.2494441529982;1040.99479502602;1102.1293178389144;1142.6914733022204;28796.856015719786;29545;30084.24789380283;32170.35659286801;33822.323553529284;1050.3067975136373;1074.4803435942702;1123.2698745815285;1146.690393593725;1198.4127777389017;14991.575800298953;15096.24518774057;15373.077615343114;15477.5356739298;15522.611934701723;815907;858348;867361;867715;868970;59007.11489327664;59009.40990590125;59196.11205831916;59471.405285947454;59641.403585963584;1300.8178854960313;1306.732119915415;1313.507434711983;1321.5440672967811;1365.3036951154982;30029.54955675623;30398.54402184013;30582;31225.37549248957;31756.841215793775;47879.281810773566;48271.75864120657;48380.516194837604;48525;48692;320925;322428;322704;324917;325263;32667.019989400356;33132.1716957078;33334.16664583405;33420.164495887795;33493.83253083817;43532.78233608938;43707.34438983354;43827.12345753131;43896.56103438925;44343.556564433944;37893.81053094717;38398.424023640226;39467.40798887962;41733.58266417297;45099.549004510845;38874.6112538871;39350.415946870635;39358;39622;39822;37965.684937958205;38307.42538861975;38762.6123738759;38787.6121238784;38836;33657;33893;37617;39783.80108099441;43677.56322436862;31943.18645552352;32113.518297226026;32158.678413216505;32276;32317 11:41:21 INFO - 2016-01-25 11:41:21,252 DEBUG : BROWSER_OUTPUT: |2;jquery.html;374.859427714607;376.1930658737011;388.89694231028767;391.46564938858455;392.3584938625348;15847.286872090755;16891.746623800653;17669.91165044173;18651.72022419663;18669.253229870807;11072.169587280945;11702.882971170307;11720.472578733956;11741.06071514279;12075.094367922396;4940.45654977953;5034.647574669774;5034.723090230036;5051.848444546669;5052.696838189702;5065.645404821664;5223.71269580173;5323.973380133094;5349.170878513836;5379.919301210465;5252.6323157379;5329.893402131955;5334.759935802898;5680.630759000673;5684.289463817023;5670.744816483227;5676;5693.060644993592;5698.287714035746;5712.171735098429;5309.601779866525;5411.512963833274;5431.158170483542;5437.945620543784;5446.645968012106;13706.177629342272;13760.793588096187;13920.791188132187;20147.496312592302;20775.272865449788;2102.611016961867;2238.9104435822546;2253.346529506441;2261.31030035839;2353.5410594933996;9897.703068907944;10007.249456290807;10044.659564382111;10348.223883208715;10405.323653962469;1917.2426891377827;1917.7506924099916;1930.3919265431343;1936.7675878894481;1973.1414200654028;67745.66127169333;70060.64969675119;70741.64629176821;71193;73080;11037.779244415067;11197.944010279896;11257.549698012152;11260.98651121403;11280.830787538194;12470.501179952882;14894.031887927467;14906.329215185342;14924.776128358084;14947.775783363259;7715.614219289013;7840.803979900548;8192.83614327722;8216.671333146607;8247.752567422987;8076.4750291230885;8092.878606820902;8094.473859199134;8111.716089936824;8165.1426600207315;4566.1552612766745;4683.250679891201;4683.297505374153;4686.461056978423;4867.561919427269;1937.4962509747568;1970.6157299326494;1991.153759652142;1996.5906989067207;2007.6787713965987;490.6663468841222;491.15276148644017;494.8935978764583;926.5737760630051;1104.0191482995942;10920;11096.1123110151;11116.333020018825;11284.887151128547;11369.545218191344;484.7842709994019;885.420049867338;962.3063408401264;997.4937843855685;1053.6786280184465;7421.480496365202;9463.858042129374;9624.422534647943;9630.662926797528;9880.65417710391;442075;442281.78859105497;444353;450702;566662;85769;88105.55947220222;88504;89279.55360223158;91580.54209729042;1154.7748189103213;1161.5818305410046;1170.8946194842506;1198.9880101198876;1204.8132539456399;16057.598560036093;16132.032078075354;16230.594235143744;16246.350145994027;16260.51218463448;36424.453633196055;36745.44881826828;36844.26311473809;38308.80845595754;38787.806060970644;49543;49583;51590.484095158565;52830.2075468876;52863;9873.45695986699;10381.636642717469;10498.580056797642;10518.737031573966;10547.57809687604;16745.497635070966;17816;18061.909690451463;18090.09549522545;18369.081545922916;14533.128012319296;14535.127892326494;14582.12507249526;15253.694926101194;15393.153376564396;14475.348609312818;15005;15062.171580563174;15209.77185342243;15294.847051529343;15002.474913377979;15199.772003419735;15201;15586.532404027897;15673.373065077269;9908.504574771088;10113.595456181965;10145.28982971185;10476.79046419052;10486.26596138263;12108.394580270775;13515.797263041259;14189;15630.843691562939;15720.76418853741 11:41:21 INFO - 2016-01-25 11:41:21,252 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1691.6193856382313;1713.4516954574538;1808.7648605681259;1863.1336428560726;1863.329201487465;7142.21435642079;7487.064116985377;7495.70017199312;7683.346915512188;7814.570198639072;7827.178146294643;7872.724454644089;7938.40461965352;7972.242636949495;8020.558869262203;2264.08304636622;2306.527161931808;2306.6770652108717;2308.122913292946;2308.4575124845646;1911.5890083632016;1914.5692219250627;1917.7219303201027;1934.303650685752;1985.7517810273716;2153.257126291427;2180.1388451561625;2204.9889750551224;2255.391044418006;2279.669447930049;2278.5898538263104;2295.1393227539675;2322.3149170994598;2328.7904088632104;2333.463303440218;2227.064632854189;2240.9663855042186;2246.247507085112;2259.9661005084936;2265.773422657721;7802.804929876742;7804.141544430108;7804.531728096333;7847.5291482510665;7864.68541258349;4631.258998560248;4656.976715116437;4709.317149013408;4732.313814496879;4749.857504274877;2934.5158048921903;2995.970040299591;3000.4599172149005;3003.609530761009;3024.3497648005564;935.2658163341744;949.4493193947563;964.5563041001147;971.6307803034802;983.6409710455704;10308.381497110197;10370.740731481697;10375.169986401146;10409;10418.27072104953;3999.8600048998146;4039.414284928669;4075.347944328893;4109.301418758818;4127.711060225755;8524.914750852537;8557.400981931329;8649.481031138152;8650.74047778555;8676.392652514263;4502.302143167814;4557.361969324297;4564.292534657067;4578.9771051144535;4597;4191.036061705825;4210.368444733253;4215.409842622035;4234.280172370704;4241.724287921275;3273.4598791199187;3312.1222875937897;3320.6513316101946;3324.1523411529906;3346.247094403788;996.4519514267124;997.7605374710017;1000.6747806962766;1007.1288335589809;1023.9692809215735;1179.9941000294943;1197.26368283505;1237.5173682263924;1459.3724698379585;1477.1137317609564;6827.283135270725;6834.6582670866255;6970.233274339818;6986.336298051677;6998.230194678581;1179.0685358566807;1182.1429463638792;1187.4597058338436;1191.666333426642;1215.0947544079718;5843.065109582446;5845.707714614252;5868.354481007086;5915.319738230072;5944.613600115978;8662.393632445668;9053.59258833354;9059.867516560429;9063.54682265884;9194.12655797698;8896.555172241362;8954.641814327484;9013.233875120688;9071.183593476619;9095.772605684911;7097.503174777819;7131.42948564124;7212.4590655699985;7212.891806622905;7258.3104605062435;7071.504994650325;7141.535800172972;7151.749688760869;7199.748008819875;7213.20654727969;7887.526748395115;7897.723579674684;7989.121196668478;8130.146334634778;8138.87791683137;8246.340292776684;8253.09215986229;8265;8271.710490132817;8285.088640249447;6704.463642908653;6833.69248383814;6879.58722476653;6888.276730943179;6914.412274956685;7328.303811137934;7384.446166537424;7417.851642967003;7420.369268612012;7437.293457121565;6607.702653380706;7153.570785752871;7303.123625165014;7373.926260737324;7385.409167266498;6628.83427914306;6679.799606011828;6681.699323530355;6682.097916781367;6981.755638552626;6912.412444942236;6985;7006.054182685272;7059.5058345915295;7061.682224299816;6451.677416129269;6488.221413430419;6503.577267477599;6507.73969041252;6508.869822603616;6314.936850631435;6423.004434312689;6471.320511346429;6671.666416679243;6681 11:41:21 INFO - 2016-01-25 11:41:21,256 DEBUG : BROWSER_OUTPUT: |4;prototype.html;335.88076232937306;351.3219486391264;352.37629395969117;352.413231968772;354.459449339757;6347.777827776017;6356.61860288383;6387.616742995418;6468.32082631324;6484.740610375585;6175.783847565336;6329.620222786636;6341.619502829833;6364;6370.649614271213;4815.783289751952;4834.178189707741;4843.58829499493;4848.903021939568;4855.101806165853;4839.080574690815;4844.2733589961435;4850.223964165734;4857.562819346258;4868.148074087038;4612.746298953573;4824.083424149418;4833.154198015351;4849.108847549459;4850.563449289563;4776.617870570346;4787.210110331791;4797.136515427222;4798.5441383068555;4808.302796094564;4207.768572728499;4217.472815898012;4219.07180420307;4222.809973551167;4229.069604686964;5922.318933322636;5998.8500287492725;6003.129546215818;6005.54958378119;6007.729652165663;5593.440655934374;5603.2435621191435;5605.523530499912;5605.831825045255;5617.578681598897;6643.900341494881;6682.498812589075;6686.197656281229;6690.698918548628;6698.531102822804;4656.720596764171;4663.743494107823;4665.976670116662;4666.53334666534;4680.555347242007;6901.896471552931;6971.965140174318;6998.335158159966;7008.649567521604;7012.719491220345;4749.881252968635;4770.379850619467;4771.212749896297;4772.284157376352;4776.402949631296;4810.037992401533;4827.61379089672;4833.879153021132;4843.515648435199;4857.441394239637;5488.847342058212;5587.329520457572;5595.972020139873;5601.075822489325;5601.215829783833;6717.261101278856;6732.158480189976;6752.898706519406;6761.763338283136;6766.72933082681;1675.1875340459867;1721.0792226158944;1726.8100508944005;1730.108993868159;1730.9740353894701;1110.0675432636463;1157.1899670230873;1169.2399940038872;1176.864660564046;1184.6090790039439;6476.708548115346;6480.708368123445;6487.18910136233;6487.2539657939;6487.286398496161;6890.93109068913;6908.516403851782;6923.065386172903;6928.757493487704;6930.757423490154;6330.746770129235;6443.871122577522;6461.547691661633;6467.902981455282;6492.610443373413;3757.868474603376;3776.546814382237;3785.564660064073;3786.110264087937;3795.7153213508545;7084.92915070853;7090.397316228075;7137.4290056795335;7141.143062832493;7147.8570428592175;7074.3633073023675;7080.433565314763;7085.43316534676;7117.501774875813;7352.595607241653;7298.051253337138;7323.853522929511;7324.157721861948;7327.890081648779;7341.265873412616;7106.538075025107;7107.147142342952;7111.964440177973;7121.323474270143;7130.857382852418;6863.485238607024;6935.271796461299;6979.720811167496;6986.685599147949;6995.615241161785;7345.816354591178;7382.926170738224;7385.261473852572;7385.781346077837;7386.0767404074495;4788.952110478851;4804.615630749462;4816.735079570517;4819.638527110411;4820.373351464287;6961.6519174042105;6963.547369421174;7042.401395881408;7104.431645468247;7110.075690160246;6857.211420686485;6886.139232595926;6889.862202756017;6896.517243792886;6917.9654101731185;6865.862682746218;6874.381305682513;6907.861842763016;6908.930910690829;6910.585364878123;6515.120458738199;6686.498512611671;6706.362895524917;6717.697703603252;6766.15423072116;6809.012693159365;6914.0666010088;6920.9653951729915;6937.132858392701;6941.34057264559;6717.227518835201;6773.085633439423;6775.457963362821;6779.423748981195;6794.8641027180165 11:41:21 INFO - 2016-01-25 11:41:21,257 DEBUG : BROWSER_OUTPUT: |5;yui.html;776.9922300776991;835.4653022065875;842.4734540911934;847.4449235750583;863.9092895245999;13727.176369417843;13931.930340348285;13948.79076813846;14036.228007459586;14048.64878378041;14093.154410735364;14220.857791422082;14325.92837035816;14382.065165764217;14679.706405871877;874.1258741258741;883.9469631822079;891.7369376034053;897.9551022448884;902.4900930974012;849.1762989899787;852.3096292003466;852.654674856684;857.3998201259112;857.4169564696004;934.5934518484447;935.4200395754642;942.3026960049548;943.3019565521499;945.1729736480579;933.276710549323;933.5239028095687;934.7055677461645;935.5369092299321;936.5457752989761;695.0824911117327;711.249631638621;715.4026387966055;715.613568672916;717.4081382859162;15122.319495622723;15145;15220.086794792238;15220.771688424682;15256.771148432783;12595.433205505775;12671.61985140438;12888.097833151684;13045.34773261333;13469.063432332357;10491.38570071094;10602.522886470128;10678.199135064824;10693.19801014927;10846.078083362845;3358.899233023013;3397.1507123219194;3422.144463884029;3425.2978139481347;3426.3489936911906;51806.74096629531;51860;52035.47964520344;52220.21669674958;52393;10233.846492302622;10397.777998214402;10487.685369438928;10551.788964220672;10786.406747628798;19149.04254787283;19362.322318718776;19378;19408.708869366972;19414.12636431364;7768.378529717609;7780.688772449039;7806.1413244543055;7884.211578842184;7918.049834019839;4501.122281155209;4507.166174257773;4596.701214421052;4644.674872758875;4752.168370535212;3241.5623890774445;3283.1627934876456;3294.2423242653845;3317.817520036373;3324.750643701732;544.335910189568;547.6960287040731;547.7452984362211;548.4844246408363;552.9336479622391;608.6074481959112;659.9208095028531;713.2403989750899;724.3625609463744;726.7347418192322;8809.911900881038;8883.067277935723;9116.361854670242;9220.861687074565;9305.813883722423;656.4125108028288;674.8717743628695;749.3667850666287;751.1099347273498;768.2202564397141;4411.955880441219;4630.745309008037;4673.906521869543;4679.906401871944;4691.5308469152815;62177.68911155415;62790.37209627845;62923;63040.369596304365;63589.68205158944;54940.45059549433;55665.72167139138;56224.71887640536;56353;56563.71718141383;49703.75148124236;49850.501494985314;49905;50789.98420031579;50935.23597146046;8525.19010694008;8622.137786221328;8747.60635771379;8859.24696400813;9031.36780425364;36203;36823;37573.62426375701;37777.62222377851;37802.62197377991;42702.57297426986;45756;48350.5164948346;48495.27257091217;49016;9252.074792520963;10471.057604815604;10613.257072004886;10919.39943303126;11255.437228138724;12143.39283035827;12450.377481126088;12458.127931044739;12585.370731463574;12606.432710528232;11812.70468238301;12062.819057714318;12102.636920892388;12617.242965422103;12629.2422454653;11304.886951130713;11374.260673056226;11430.085593152695;11661.06711463064;11806.645800625995;10659.307145035547;10783.568657253621;10924.235303528994;10970.945145274223;11338.263012904135;9270.490123043297;9614.807703846023;9664.468454235084;9752.122308992224;9859.901400985898;9308.208802251613;9336.579853906725;9862.950685246527;9897.109260166619;9904.108630223314 11:41:21 INFO - 2016-01-25 11:41:21,257 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:41:21 INFO - 2016-01-25 11:41:21,257 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:41:21 INFO - 2016-01-25 11:41:21,257 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,309 11:41:21 INFO - 2016-01-25 11:41:21,257 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:41:21 INFO - 2016-01-25 11:41:21,257 DEBUG : BROWSER_OUTPUT: __startTimestamp1453750881243__endTimestamp 11:41:21 INFO - 2016-01-25 11:41:21,257 DEBUG : BROWSER_OUTPUT: 11:41:21 INFO - 2016-01-25 11:41:21,258 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:41:21 INFO - 2016-01-25 11:41:21,258 DEBUG : BROWSER_OUTPUT: Number of tests: 6 11:41:21 INFO - 2016-01-25 11:41:21,258 DEBUG : BROWSER_OUTPUT: 11:41:21 INFO - 2016-01-25 11:41:21,258 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5524.14 Median:5712.11 stddev:623.97 (10.9%) stddev-sans-first:599.46 11:41:21 INFO - 2016-01-25 11:41:21,258 DEBUG : BROWSER_OUTPUT: Values: 3233.9 3271.6 3281.4 3299.2 3302.0 5409.1 5429.3 5443.4 5444.3 5458.9 5515.5 5538.9 5545.4 5557.3 5584.7 4962.7 5034.5 5049.5 5110.7 5131.6 4825.2 4987.4 4994.8 5006.2 5080.3 4977.8 5080.4 5080.4 5093.0 5166.2 5097.1 5128.7 5129.1 5135.1 5153.6 4853.8 4889.0 4950.8 5041.9 5059.3 5365.4 5369.5 5420.4 5441.5 5449.2 5920.7 5978.6 6004.1 6027.8 6028.2 5794.5 5896.2 5928.6 5976.1 6067.0 5596.5 5602.9 5605.4 5626.4 5637.4 6087.5 6101.2 6102.6 6105.1 6109.9 5606.7 5693.8 5709.5 5782.5 5832.9 5950.7 5967.0 5975.3 5977.0 5997.5 5899.3 5925.9 5930.2 5939.3 5954.2 5678.7 5749.0 5857.1 5965.3 5980.5 4577.4 4585.7 4591.6 4593.8 4612.3 3962.9 4099.3 4109.5 4115.4 4121.2 5576.6 5594.2 5635.6 5709.1 5727.1 5951.2 5981.9 6006.6 6026.5 6039.3 5380.3 5486.2 5582.3 5618.2 5664.7 5094.0 5182.0 5189.1 5196.7 5199.5 6184.1 6206.3 6211.3 6224.4 6228.8 5758.2 5820.8 5878.8 6067.2 6071.3 6082.0 6127.7 6137.1 6141.1 6144.4 5903.8 5959.3 5968.5 5969.4 6007.5 5751.8 5856.1 6048.2 6049.4 6079.3 5719.8 5763.9 5774.5 5793.4 5821.3 5897.0 5900.9 5903.9 5904.4 5932.5 5603.1 5644.7 5681.6 5712.1 5761.8 5901.8 5921.8 5929.5 5942.3 5970.2 5708.6 5785.7 5812.2 5827.2 5832.2 11:41:21 INFO - 2016-01-25 11:41:21,258 DEBUG : BROWSER_OUTPUT: 11:41:21 INFO - 2016-01-25 11:41:21,259 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:64800.91 Median:39354.21 stddev:150560.23 (382.6%) stddev-sans-first:150905.40 11:41:21 INFO - 2016-01-25 11:41:21,259 DEBUG : BROWSER_OUTPUT: Values: 590.9 632.6 637.3 639.8 700.0 31985.2 40409.6 40413.4 40465.0 40517.6 43134.1 43826.1 43848.8 43857.3 43898.8 8990.6 9061.5 9146.8 9153.7 9167.2 8665.6 8794.3 8807.9 8830.5 8841.8 8937.7 8939.3 8952.9 8987.2 9029.2 8935.3 8980.2 9010.0 9036.6 9049.1 8859.8 8937.0 9002.4 9009.9 9026.4 40754.8 40800.8 40979.8 41032.4 41253.4 3645.8 3675.4 3684.6 3789.7 4067.6 34357.3 34393.5 34450.5 34803.5 34953.3 3579.4 3589.6 3613.3 3721.0 3725.1 299738.0 302646.0 302996.0 303164.0 304352.0 48516.5 48810.3 69754.0 70895.6 70947.3 64836.4 65237.0 65268.0 65338.7 65380.3 16439.2 16591.7 16624.3 16680.9 16695.4 12610.5 12657.7 12783.2 12877.7 12996.9 21626.2 21846.3 21893.8 21895.5 21970.6 8613.2 8674.3 8697.5 8717.8 8787.4 946.2 1035.2 1041.0 1102.1 1142.7 28796.9 29545.0 30084.2 32170.4 33822.3 1050.3 1074.5 1123.3 1146.7 1198.4 14991.6 15096.2 15373.1 15477.5 15522.6 815907.0 858348.0 867361.0 867715.0 868970.0 59007.1 59009.4 59196.1 59471.4 59641.4 1300.8 1306.7 1313.5 1321.5 1365.3 30029.5 30398.5 30582.0 31225.4 31756.8 47879.3 48271.8 48380.5 48525.0 48692.0 320925.0 322428.0 322704.0 324917.0 325263.0 32667.0 33132.2 33334.2 33420.2 33493.8 43532.8 43707.3 43827.1 43896.6 44343.6 37893.8 38398.4 39467.4 41733.6 45099.5 38874.6 39350.4 39358.0 39622.0 39822.0 37965.7 38307.4 38762.6 38787.6 38836.0 33657.0 33893.0 37617.0 39783.8 43677.6 31943.2 32113.5 32158.7 32276.0 32317.0 11:41:21 INFO - 2016-01-25 11:41:21,259 DEBUG : BROWSER_OUTPUT: 11:41:21 INFO - 2016-01-25 11:41:21,259 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27498.83 Median:2246.13 stddev:77597.64 (3454.7%) stddev-sans-first:77788.60 11:41:21 INFO - 2016-01-25 11:41:21,261 DEBUG : BROWSER_OUTPUT: Values: 374.9 376.2 388.9 391.5 392.4 15847.3 16891.7 17669.9 18651.7 18669.3 11072.2 11702.9 11720.5 11741.1 12075.1 4940.5 5034.6 5034.7 5051.8 5052.7 5065.6 5223.7 5324.0 5349.2 5379.9 5252.6 5329.9 5334.8 5680.6 5684.3 5670.7 5676.0 5693.1 5698.3 5712.2 5309.6 5411.5 5431.2 5437.9 5446.6 13706.2 13760.8 13920.8 20147.5 20775.3 2102.6 2238.9 2253.3 2261.3 2353.5 9897.7 10007.2 10044.7 10348.2 10405.3 1917.2 1917.8 1930.4 1936.8 1973.1 67745.7 70060.6 70741.6 71193.0 73080.0 11037.8 11197.9 11257.5 11261.0 11280.8 12470.5 14894.0 14906.3 14924.8 14947.8 7715.6 7840.8 8192.8 8216.7 8247.8 8076.5 8092.9 8094.5 8111.7 8165.1 4566.2 4683.3 4683.3 4686.5 4867.6 1937.5 1970.6 1991.2 1996.6 2007.7 490.7 491.2 494.9 926.6 1104.0 10920.0 11096.1 11116.3 11284.9 11369.5 484.8 885.4 962.3 997.5 1053.7 7421.5 9463.9 9624.4 9630.7 9880.7 442075.0 442281.8 444353.0 450702.0 566662.0 85769.0 88105.6 88504.0 89279.6 91580.5 1154.8 1161.6 1170.9 1199.0 1204.8 16057.6 16132.0 16230.6 16246.4 16260.5 36424.5 36745.4 36844.3 38308.8 38787.8 49543.0 49583.0 51590.5 52830.2 52863.0 9873.5 10381.6 10498.6 10518.7 10547.6 16745.5 17816.0 18061.9 18090.1 18369.1 14533.1 14535.1 14582.1 15253.7 15393.2 14475.3 15005.0 15062.2 15209.8 15294.8 15002.5 15199.8 15201.0 15586.5 15673.4 9908.5 10113.6 10145.3 10476.8 10486.3 12108.4 13515.8 14189.0 15630.8 15720.8 11:41:21 INFO - 2016-01-25 11:41:21,261 DEBUG : BROWSER_OUTPUT: 11:41:21 INFO - 2016-01-25 11:41:21,261 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5359.84 Median:6558.29 stddev:2747.10 (41.9%) stddev-sans-first:2740.97 11:41:21 INFO - 2016-01-25 11:41:21,262 DEBUG : BROWSER_OUTPUT: Values: 1691.6 1713.5 1808.8 1863.1 1863.3 7142.2 7487.1 7495.7 7683.3 7814.6 7827.2 7872.7 7938.4 7972.2 8020.6 2264.1 2306.5 2306.7 2308.1 2308.5 1911.6 1914.6 1917.7 1934.3 1985.8 2153.3 2180.1 2205.0 2255.4 2279.7 2278.6 2295.1 2322.3 2328.8 2333.5 2227.1 2241.0 2246.2 2260.0 2265.8 7802.8 7804.1 7804.5 7847.5 7864.7 4631.3 4657.0 4709.3 4732.3 4749.9 2934.5 2996.0 3000.5 3003.6 3024.3 935.3 949.4 964.6 971.6 983.6 10308.4 10370.7 10375.2 10409.0 10418.3 3999.9 4039.4 4075.3 4109.3 4127.7 8524.9 8557.4 8649.5 8650.7 8676.4 4502.3 4557.4 4564.3 4579.0 4597.0 4191.0 4210.4 4215.4 4234.3 4241.7 3273.5 3312.1 3320.7 3324.2 3346.2 996.5 997.8 1000.7 1007.1 1024.0 1180.0 1197.3 1237.5 1459.4 1477.1 6827.3 6834.7 6970.2 6986.3 6998.2 1179.1 1182.1 1187.5 1191.7 1215.1 5843.1 5845.7 5868.4 5915.3 5944.6 8662.4 9053.6 9059.9 9063.5 9194.1 8896.6 8954.6 9013.2 9071.2 9095.8 7097.5 7131.4 7212.5 7212.9 7258.3 7071.5 7141.5 7151.7 7199.7 7213.2 7887.5 7897.7 7989.1 8130.1 8138.9 8246.3 8253.1 8265.0 8271.7 8285.1 6704.5 6833.7 6879.6 6888.3 6914.4 7328.3 7384.4 7417.9 7420.4 7437.3 6607.7 7153.6 7303.1 7373.9 7385.4 6628.8 6679.8 6681.7 6682.1 6981.8 6912.4 6985.0 7006.1 7059.5 7061.7 6451.7 6488.2 6503.6 6507.7 6508.9 6314.9 6423.0 6471.3 6671.7 6681.0 11:41:21 INFO - 2016-01-25 11:41:21,262 DEBUG : BROWSER_OUTPUT: 11:41:21 INFO - 2016-01-25 11:41:21,263 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5664.50 Median:6464.73 stddev:1722.29 (26.6%) stddev-sans-first:1680.04 11:41:21 INFO - 2016-01-25 11:41:21,263 DEBUG : BROWSER_OUTPUT: Values: 335.9 351.3 352.4 352.4 354.5 6347.8 6356.6 6387.6 6468.3 6484.7 6175.8 6329.6 6341.6 6364.0 6370.6 4815.8 4834.2 4843.6 4848.9 4855.1 4839.1 4844.3 4850.2 4857.6 4868.1 4612.7 4824.1 4833.2 4849.1 4850.6 4776.6 4787.2 4797.1 4798.5 4808.3 4207.8 4217.5 4219.1 4222.8 4229.1 5922.3 5998.9 6003.1 6005.5 6007.7 5593.4 5603.2 5605.5 5605.8 5617.6 6643.9 6682.5 6686.2 6690.7 6698.5 4656.7 4663.7 4666.0 4666.5 4680.6 6901.9 6972.0 6998.3 7008.6 7012.7 4749.9 4770.4 4771.2 4772.3 4776.4 4810.0 4827.6 4833.9 4843.5 4857.4 5488.8 5587.3 5596.0 5601.1 5601.2 6717.3 6732.2 6752.9 6761.8 6766.7 1675.2 1721.1 1726.8 1730.1 1731.0 1110.1 1157.2 1169.2 1176.9 1184.6 6476.7 6480.7 6487.2 6487.3 6487.3 6890.9 6908.5 6923.1 6928.8 6930.8 6330.7 6443.9 6461.5 6467.9 6492.6 3757.9 3776.5 3785.6 3786.1 3795.7 7084.9 7090.4 7137.4 7141.1 7147.9 7074.4 7080.4 7085.4 7117.5 7352.6 7298.1 7323.9 7324.2 7327.9 7341.3 7106.5 7107.1 7112.0 7121.3 7130.9 6863.5 6935.3 6979.7 6986.7 6995.6 7345.8 7382.9 7385.3 7385.8 7386.1 4789.0 4804.6 4816.7 4819.6 4820.4 6961.7 6963.5 7042.4 7104.4 7110.1 6857.2 6886.1 6889.9 6896.5 6918.0 6865.9 6874.4 6907.9 6908.9 6910.6 6515.1 6686.5 6706.4 6717.7 6766.2 6809.0 6914.1 6921.0 6937.1 6941.3 6717.2 6773.1 6775.5 6779.4 6794.9 11:41:21 INFO - 2016-01-25 11:41:21,263 DEBUG : BROWSER_OUTPUT: 11:41:21 INFO - 2016-01-25 11:41:21,263 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14660.73 Median:49877.75 stddev:17300.32 (34.7%) stddev-sans-first:17317.44 11:41:21 INFO - 2016-01-25 11:41:21,263 DEBUG : BROWSER_OUTPUT: Values: 777.0 835.5 842.5 847.4 863.9 13727.2 13931.9 13948.8 14036.2 14048.6 14093.2 14220.9 14325.9 14382.1 14679.7 874.1 883.9 891.7 898.0 902.5 849.2 852.3 852.7 857.4 857.4 934.6 935.4 942.3 943.3 945.2 933.3 933.5 934.7 935.5 936.5 695.1 711.2 715.4 715.6 717.4 15122.3 15145.0 15220.1 15220.8 15256.8 12595.4 12671.6 12888.1 13045.3 13469.1 10491.4 10602.5 10678.2 10693.2 10846.1 3358.9 3397.2 3422.1 3425.3 3426.3 51806.7 51860.0 52035.5 52220.2 52393.0 10233.8 10397.8 10487.7 10551.8 10786.4 19149.0 19362.3 19378.0 19408.7 19414.1 7768.4 7780.7 7806.1 7884.2 7918.0 4501.1 4507.2 4596.7 4644.7 4752.2 3241.6 3283.2 3294.2 3317.8 3324.8 544.3 547.7 547.7 548.5 552.9 608.6 659.9 713.2 724.4 726.7 8809.9 8883.1 9116.4 9220.9 9305.8 656.4 674.9 749.4 751.1 768.2 4412.0 4630.7 4673.9 4679.9 4691.5 62177.7 62790.4 62923.0 63040.4 63589.7 54940.5 55665.7 56224.7 56353.0 56563.7 49703.8 49850.5 49905.0 50790.0 50935.2 8525.2 8622.1 8747.6 8859.2 9031.4 36203.0 36823.0 37573.6 37777.6 37802.6 42702.6 45756.0 48350.5 48495.3 49016.0 9252.1 10471.1 10613.3 10919.4 11255.4 12143.4 12450.4 12458.1 12585.4 12606.4 11812.7 12062.8 12102.6 12617.2 12629.2 11304.9 11374.3 11430.1 11661.1 11806.6 10659.3 10783.6 10924.2 10970.9 11338.3 9270.5 9614.8 9664.5 9752.1 9859.9 9308.2 9336.6 9863.0 9897.1 9904.1 11:41:21 INFO - 2016-01-25 11:41:21,263 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:41:21 INFO - 2016-01-25 11:41:21,263 DEBUG : BROWSER_OUTPUT: 11:41:21 INFO - 2016-01-25 11:41:21,912 INFO : Browser exited with error code: 0 11:41:21 INFO - 2016-01-25 11:41:21,933 INFO : Completed test dromaeo_css (00:18:28) 11:41:21 INFO - 2016-01-25 11:41:21,933 INFO : Starting test kraken 11:41:21 INFO - 2016-01-25 11:41:21,933 DEBUG : operating with platform_type : linux_ 11:41:21 INFO - 2016-01-25 11:41:21,933 INFO : Initialising browser for kraken test... 11:41:21 INFO - 2016-01-25 11:41:21,940 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpROnyKt/profile http://localhost:60771/getInfo.html 11:41:25 INFO - 2016-01-25 11:41:25,534 DEBUG : BROWSER_OUTPUT: 11:41:25 INFO - 2016-01-25 11:41:25,534 DEBUG : BROWSER_OUTPUT: (process:26149): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:41:26 INFO - 2016-01-25 11:41:26,442 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:41:26 INFO - 2016-01-25 11:41:26,442 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:41:26 INFO - 2016-01-25 11:41:26,442 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:41:26 INFO - 2016-01-25 11:41:26,442 DEBUG : BROWSER_OUTPUT: __metrics 11:41:27 INFO - 2016-01-25 11:41:27,372 INFO : Browser initialized. 11:41:27 INFO - 2016-01-25 11:41:27,372 INFO : Running cycle 1/1 for kraken test... 11:41:27 INFO - 2016-01-25 11:41:27,373 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpROnyKt/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:41:28 INFO - 2016-01-25 11:41:28,636 DEBUG : BROWSER_OUTPUT: 11:41:28 INFO - 2016-01-25 11:41:28,636 DEBUG : BROWSER_OUTPUT: (process:26263): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:41:39 INFO - 2016-01-25 11:41:39,142 DEBUG : BROWSER_OUTPUT: RSS: Main: 135487488 11:41:39 INFO - 2016-01-25 11:41:39,143 DEBUG : BROWSER_OUTPUT: 11:41:41 INFO - 2016-01-25 11:41:41,629 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60771/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60771/tests/kraken/driver.html?testName=audio-beat-detection) 11:41:42 INFO - 2016-01-25 11:41:42,223 DEBUG : BROWSER_OUTPUT: RSS: Main: 137940992 11:41:42 INFO - 2016-01-25 11:41:42,223 DEBUG : BROWSER_OUTPUT: 11:41:44 INFO - 2016-01-25 11:41:44,820 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60771/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60771/tests/kraken/driver.html?testName=audio-dft) 11:41:45 INFO - 2016-01-25 11:41:45,406 DEBUG : BROWSER_OUTPUT: RSS: Main: 138383360 11:41:45 INFO - 2016-01-25 11:41:45,406 DEBUG : BROWSER_OUTPUT: 11:41:48 INFO - 2016-01-25 11:41:48,213 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60771/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60771/tests/kraken/driver.html?testName=audio-fft) 11:41:48 INFO - 2016-01-25 11:41:48,787 DEBUG : BROWSER_OUTPUT: RSS: Main: 137347072 11:41:48 INFO - 2016-01-25 11:41:48,787 DEBUG : BROWSER_OUTPUT: 11:41:50 INFO - 2016-01-25 11:41:50,820 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60771/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60771/tests/kraken/driver.html?testName=audio-oscillator) 11:41:51 INFO - 2016-01-25 11:41:51,406 DEBUG : BROWSER_OUTPUT: RSS: Main: 138014720 11:41:51 INFO - 2016-01-25 11:41:51,406 DEBUG : BROWSER_OUTPUT: 11:41:53 INFO - 2016-01-25 11:41:53,579 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60771/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60771/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:41:54 INFO - 2016-01-25 11:41:54,152 DEBUG : BROWSER_OUTPUT: RSS: Main: 139059200 11:41:54 INFO - 2016-01-25 11:41:54,152 DEBUG : BROWSER_OUTPUT: 11:41:57 INFO - 2016-01-25 11:41:57,079 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60771/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60771/tests/kraken/driver.html?testName=imaging-darkroom) 11:41:57 INFO - 2016-01-25 11:41:57,668 DEBUG : BROWSER_OUTPUT: RSS: Main: 138932224 11:41:57 INFO - 2016-01-25 11:41:57,668 DEBUG : BROWSER_OUTPUT: 11:42:00 INFO - 2016-01-25 11:42:00,974 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60771/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60771/tests/kraken/driver.html?testName=imaging-desaturate) 11:42:01 INFO - 2016-01-25 11:42:01,563 DEBUG : BROWSER_OUTPUT: RSS: Main: 138989568 11:42:01 INFO - 2016-01-25 11:42:01,563 DEBUG : BROWSER_OUTPUT: 11:42:04 INFO - 2016-01-25 11:42:04,373 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60771/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60771/tests/kraken/driver.html?testName=json-parse-financial) 11:42:04 INFO - 2016-01-25 11:42:04,959 DEBUG : BROWSER_OUTPUT: RSS: Main: 139317248 11:42:04 INFO - 2016-01-25 11:42:04,959 DEBUG : BROWSER_OUTPUT: 11:42:06 INFO - 2016-01-25 11:42:06,507 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60771/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60771/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:42:07 INFO - 2016-01-25 11:42:07,081 DEBUG : BROWSER_OUTPUT: RSS: Main: 138141696 11:42:07 INFO - 2016-01-25 11:42:07,081 DEBUG : BROWSER_OUTPUT: 11:42:08 INFO - 2016-01-25 11:42:08,851 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60771/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60771/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:42:09 INFO - 2016-01-25 11:42:09,459 DEBUG : BROWSER_OUTPUT: RSS: Main: 137850880 11:42:09 INFO - 2016-01-25 11:42:09,459 DEBUG : BROWSER_OUTPUT: 11:42:11 INFO - 2016-01-25 11:42:11,492 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60771/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60771/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:42:12 INFO - 2016-01-25 11:42:12,078 DEBUG : BROWSER_OUTPUT: RSS: Main: 139038720 11:42:12 INFO - 2016-01-25 11:42:12,078 DEBUG : BROWSER_OUTPUT: 11:42:14 INFO - 2016-01-25 11:42:14,444 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60771/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60771/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:42:15 INFO - 2016-01-25 11:42:15,046 DEBUG : BROWSER_OUTPUT: RSS: Main: 139558912 11:42:15 INFO - 2016-01-25 11:42:15,046 DEBUG : BROWSER_OUTPUT: 11:42:17 INFO - 2016-01-25 11:42:17,621 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60771/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60771/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:42:18 INFO - 2016-01-25 11:42:18,203 DEBUG : BROWSER_OUTPUT: RSS: Main: 138584064 11:42:18 INFO - 2016-01-25 11:42:18,203 DEBUG : BROWSER_OUTPUT: 11:42:19 INFO - 2016-01-25 11:42:19,864 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60771/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60771/tests/kraken/driver.html?testName=ai-astar) 11:42:20 INFO - 2016-01-25 11:42:20,115 DEBUG : BROWSER_OUTPUT: RSS: Main: 138903552 11:42:20 INFO - 2016-01-25 11:42:20,115 DEBUG : BROWSER_OUTPUT: 11:42:20 INFO - 2016-01-25 11:42:20,115 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:42:20 INFO - 2016-01-25 11:42:20,115 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:42:20 INFO - 2016-01-25 11:42:20,116 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:42:20 INFO - 2016-01-25 11:42:20,116 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:42:20 INFO - 2016-01-25 11:42:20,116 DEBUG : BROWSER_OUTPUT: |0;ai-astar;114;106;111;111;113;121;113;111;111;111 11:42:20 INFO - 2016-01-25 11:42:20,116 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;143;133;152;154;125;155;148;129;158;123 11:42:20 INFO - 2016-01-25 11:42:20,117 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;162;162;162;162;160;160;160;164;163 11:42:20 INFO - 2016-01-25 11:42:20,117 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;72;160;72;72;70;71;160;75 11:42:20 INFO - 2016-01-25 11:42:20,118 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;93;136;94;93;92;138;92;92;134 11:42:20 INFO - 2016-01-25 11:42:20,118 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;109;109;110;111;110;109;110;109 11:42:20 INFO - 2016-01-25 11:42:20,118 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;146;147;147;148;147;146;146;147 11:42:20 INFO - 2016-01-25 11:42:20,118 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;97;96;96;95;96;97;96;96;96 11:42:20 INFO - 2016-01-25 11:42:20,119 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;56;59;57;58;57;58;60;57;60;56 11:42:20 INFO - 2016-01-25 11:42:20,119 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;64;64;64;64;64;63;63;64;63 11:42:20 INFO - 2016-01-25 11:42:20,119 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;79;82;82;83;89;81;84;82;80;84 11:42:20 INFO - 2016-01-25 11:42:20,119 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;119;113;111;120;115;111;128;119;119;125 11:42:20 INFO - 2016-01-25 11:42:20,119 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;154;149;155;149;149;148;152;139;153;147 11:42:20 INFO - 2016-01-25 11:42:20,119 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;66;65;65;66;64;68;65;72;65 11:42:20 INFO - 2016-01-25 11:42:20,119 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:42:20 INFO - 2016-01-25 11:42:20,119 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:42:20 INFO - 2016-01-25 11:42:20,120 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,699 11:42:20 INFO - 2016-01-25 11:42:20,120 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:42:20 INFO - 2016-01-25 11:42:20,120 DEBUG : BROWSER_OUTPUT: __startTimestamp1453750940114__endTimestamp 11:42:20 INFO - 2016-01-25 11:42:20,120 DEBUG : BROWSER_OUTPUT: 11:42:20 INFO - 2016-01-25 11:42:20,123 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:42:20 INFO - 2016-01-25 11:42:20,124 DEBUG : BROWSER_OUTPUT: Number of tests: 14 11:42:20 INFO - 2016-01-25 11:42:20,124 DEBUG : BROWSER_OUTPUT: 11:42:20 INFO - 2016-01-25 11:42:20,124 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.20 Median:112.00 stddev:3.77 (3.4%) stddev-sans-first:3.94 11:42:20 INFO - 2016-01-25 11:42:20,124 DEBUG : BROWSER_OUTPUT: Values: 114.0 106.0 111.0 111.0 113.0 121.0 113.0 111.0 111.0 111.0 11:42:20 INFO - 2016-01-25 11:42:20,125 DEBUG : BROWSER_OUTPUT: 11:42:20 INFO - 2016-01-25 11:42:20,125 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.00 Median:150.00 stddev:13.36 (8.9%) stddev-sans-first:14.16 11:42:20 INFO - 2016-01-25 11:42:20,125 DEBUG : BROWSER_OUTPUT: Values: 143.0 133.0 152.0 154.0 125.0 155.0 148.0 129.0 158.0 123.0 11:42:20 INFO - 2016-01-25 11:42:20,125 DEBUG : BROWSER_OUTPUT: 11:42:20 INFO - 2016-01-25 11:42:20,125 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.35 (0.8%) stddev-sans-first:1.41 11:42:20 INFO - 2016-01-25 11:42:20,125 DEBUG : BROWSER_OUTPUT: Values: 161.0 162.0 162.0 162.0 162.0 160.0 160.0 160.0 164.0 163.0 11:42:20 INFO - 2016-01-25 11:42:20,126 DEBUG : BROWSER_OUTPUT: 11:42:20 INFO - 2016-01-25 11:42:20,126 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:89.70 Median:72.00 stddev:37.07 (51.5%) stddev-sans-first:38.77 11:42:20 INFO - 2016-01-25 11:42:20,126 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 72.0 160.0 72.0 72.0 70.0 71.0 160.0 75.0 11:42:20 INFO - 2016-01-25 11:42:20,126 DEBUG : BROWSER_OUTPUT: 11:42:20 INFO - 2016-01-25 11:42:20,126 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.60 Median:92.00 stddev:21.01 (22.8%) stddev-sans-first:21.70 11:42:20 INFO - 2016-01-25 11:42:20,126 DEBUG : BROWSER_OUTPUT: Values: 92.0 93.0 136.0 94.0 93.0 92.0 138.0 92.0 92.0 134.0 11:42:20 INFO - 2016-01-25 11:42:20,127 DEBUG : BROWSER_OUTPUT: 11:42:20 INFO - 2016-01-25 11:42:20,127 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 11:42:20 INFO - 2016-01-25 11:42:20,127 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 109.0 109.0 110.0 111.0 110.0 109.0 110.0 109.0 11:42:20 INFO - 2016-01-25 11:42:20,127 DEBUG : BROWSER_OUTPUT: 11:42:20 INFO - 2016-01-25 11:42:20,127 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 11:42:20 INFO - 2016-01-25 11:42:20,128 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 146.0 147.0 147.0 148.0 147.0 146.0 146.0 147.0 11:42:20 INFO - 2016-01-25 11:42:20,128 DEBUG : BROWSER_OUTPUT: 11:42:20 INFO - 2016-01-25 11:42:20,128 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:20 INFO - 2016-01-25 11:42:20,128 DEBUG : BROWSER_OUTPUT: Values: 96.0 97.0 96.0 96.0 95.0 96.0 97.0 96.0 96.0 96.0 11:42:20 INFO - 2016-01-25 11:42:20,128 DEBUG : BROWSER_OUTPUT: 11:42:20 INFO - 2016-01-25 11:42:20,128 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:57.80 Median:58.00 stddev:1.48 (2.5%) stddev-sans-first:1.41 11:42:20 INFO - 2016-01-25 11:42:20,128 DEBUG : BROWSER_OUTPUT: Values: 56.0 59.0 57.0 58.0 57.0 58.0 60.0 57.0 60.0 56.0 11:42:20 INFO - 2016-01-25 11:42:20,128 DEBUG : BROWSER_OUTPUT: 11:42:20 INFO - 2016-01-25 11:42:20,128 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:63.60 Median:64.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 11:42:20 INFO - 2016-01-25 11:42:20,128 DEBUG : BROWSER_OUTPUT: Values: 63.0 64.0 64.0 64.0 64.0 64.0 63.0 63.0 64.0 63.0 11:42:20 INFO - 2016-01-25 11:42:20,129 DEBUG : BROWSER_OUTPUT: 11:42:20 INFO - 2016-01-25 11:42:20,129 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:82.50 stddev:2.76 (3.3%) stddev-sans-first:2.60 11:42:20 INFO - 2016-01-25 11:42:20,129 DEBUG : BROWSER_OUTPUT: Values: 79.0 82.0 82.0 83.0 89.0 81.0 84.0 82.0 80.0 84.0 11:42:20 INFO - 2016-01-25 11:42:20,129 DEBUG : BROWSER_OUTPUT: 11:42:20 INFO - 2016-01-25 11:42:20,129 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:118.00 Median:119.00 stddev:5.66 (4.8%) stddev-sans-first:5.99 11:42:20 INFO - 2016-01-25 11:42:20,129 DEBUG : BROWSER_OUTPUT: Values: 119.0 113.0 111.0 120.0 115.0 111.0 128.0 119.0 119.0 125.0 11:42:20 INFO - 2016-01-25 11:42:20,129 DEBUG : BROWSER_OUTPUT: 11:42:20 INFO - 2016-01-25 11:42:20,129 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.50 Median:150.50 stddev:4.58 (3.0%) stddev-sans-first:4.56 11:42:20 INFO - 2016-01-25 11:42:20,129 DEBUG : BROWSER_OUTPUT: Values: 154.0 149.0 155.0 149.0 149.0 148.0 152.0 139.0 153.0 147.0 11:42:20 INFO - 2016-01-25 11:42:20,129 DEBUG : BROWSER_OUTPUT: 11:42:20 INFO - 2016-01-25 11:42:20,129 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.00 stddev:2.31 (3.5%) stddev-sans-first:2.44 11:42:20 INFO - 2016-01-25 11:42:20,129 DEBUG : BROWSER_OUTPUT: Values: 67.0 66.0 65.0 65.0 66.0 64.0 68.0 65.0 72.0 65.0 11:42:20 INFO - 2016-01-25 11:42:20,129 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:42:20 INFO - 2016-01-25 11:42:20,129 DEBUG : BROWSER_OUTPUT: 11:42:20 INFO - 2016-01-25 11:42:20,964 INFO : Browser exited with error code: 0 11:42:21 INFO - 2016-01-25 11:42:21,082 INFO : Completed test kraken (00:00:59) 11:42:21 INFO - 2016-01-25 11:42:21,083 INFO : Starting test v8_7 11:42:21 INFO - 2016-01-25 11:42:21,083 DEBUG : operating with platform_type : linux_ 11:42:21 INFO - 2016-01-25 11:42:21,083 INFO : Initialising browser for v8_7 test... 11:42:21 INFO - 2016-01-25 11:42:21,089 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9Isi3i/profile http://localhost:60771/getInfo.html 11:42:24 INFO - 2016-01-25 11:42:24,809 DEBUG : BROWSER_OUTPUT: 11:42:24 INFO - 2016-01-25 11:42:24,809 DEBUG : BROWSER_OUTPUT: (process:26574): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:42:25 INFO - 2016-01-25 11:42:25,631 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:42:25 INFO - 2016-01-25 11:42:25,631 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:42:25 INFO - 2016-01-25 11:42:25,631 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:42:25 INFO - 2016-01-25 11:42:25,631 DEBUG : BROWSER_OUTPUT: __metrics 11:42:26 INFO - 2016-01-25 11:42:26,588 INFO : Browser initialized. 11:42:26 INFO - 2016-01-25 11:42:26,588 INFO : Running cycle 1/1 for v8_7 test... 11:42:26 INFO - 2016-01-25 11:42:26,589 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9Isi3i/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:27 INFO - 2016-01-25 11:42:27,940 DEBUG : BROWSER_OUTPUT: 11:42:27 INFO - 2016-01-25 11:42:27,941 DEBUG : BROWSER_OUTPUT: (process:26691): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:42:38 INFO - 2016-01-25 11:42:38,444 DEBUG : BROWSER_OUTPUT: RSS: Main: 138211328 11:42:38 INFO - 2016-01-25 11:42:38,444 DEBUG : BROWSER_OUTPUT: 11:42:59 INFO - 2016-01-25 11:42:59,821 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60771/tests/v8_7/run.html (next: http://localhost:60771/tests/v8_7/run.html) 11:43:00 INFO - 2016-01-25 11:43:00,071 DEBUG : BROWSER_OUTPUT: RSS: Main: 135999488 11:43:00 INFO - 2016-01-25 11:43:00,072 DEBUG : BROWSER_OUTPUT: 11:43:00 INFO - 2016-01-25 11:43:00,072 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:43:00 INFO - 2016-01-25 11:43:00,072 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:43:00 INFO - 2016-01-25 11:43:00,072 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:43:00 INFO - 2016-01-25 11:43:00,072 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:43:00 INFO - 2016-01-25 11:43:00,073 DEBUG : BROWSER_OUTPUT: |0;Richards;167.84155756965424 11:43:00 INFO - 2016-01-25 11:43:00,073 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;167.1402306535183 11:43:00 INFO - 2016-01-25 11:43:00,073 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.4076557697681 11:43:00 INFO - 2016-01-25 11:43:00,073 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5133.333333333333 11:43:00 INFO - 2016-01-25 11:43:00,073 DEBUG : BROWSER_OUTPUT: |4;RayTrace;925.925925925926 11:43:00 INFO - 2016-01-25 11:43:00,073 DEBUG : BROWSER_OUTPUT: |5;Earley;547.945205479452 11:43:00 INFO - 2016-01-25 11:43:00,073 DEBUG : BROWSER_OUTPUT: |6;Boyer;11021.739130434782 11:43:00 INFO - 2016-01-25 11:43:00,075 DEBUG : BROWSER_OUTPUT: |7;RegExp;23809.52380952381 11:43:00 INFO - 2016-01-25 11:43:00,075 DEBUG : BROWSER_OUTPUT: |8;Splay;525.2100840336135 11:43:00 INFO - 2016-01-25 11:43:00,075 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 11:43:00 INFO - 2016-01-25 11:43:00,075 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:43:00 INFO - 2016-01-25 11:43:00,075 DEBUG : BROWSER_OUTPUT: __startTimestamp1453750980071__endTimestamp 11:43:00 INFO - 2016-01-25 11:43:00,076 DEBUG : BROWSER_OUTPUT: 11:43:00 INFO - 2016-01-25 11:43:00,076 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:43:00 INFO - 2016-01-25 11:43:00,076 DEBUG : BROWSER_OUTPUT: Number of tests: 10 11:43:00 INFO - 2016-01-25 11:43:00,076 DEBUG : BROWSER_OUTPUT: 11:43:00 INFO - 2016-01-25 11:43:00,076 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.84 Median:167.84 stddev:0.00 (0.0%) 11:43:00 INFO - 2016-01-25 11:43:00,076 DEBUG : BROWSER_OUTPUT: Values: 167.8 11:43:00 INFO - 2016-01-25 11:43:00,076 DEBUG : BROWSER_OUTPUT: 11:43:00 INFO - 2016-01-25 11:43:00,076 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:167.14 Median:167.14 stddev:0.00 (0.0%) 11:43:00 INFO - 2016-01-25 11:43:00,076 DEBUG : BROWSER_OUTPUT: Values: 167.1 11:43:00 INFO - 2016-01-25 11:43:00,076 DEBUG : BROWSER_OUTPUT: 11:43:00 INFO - 2016-01-25 11:43:00,076 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.41 Median:279.41 stddev:0.00 (0.0%) 11:43:00 INFO - 2016-01-25 11:43:00,076 DEBUG : BROWSER_OUTPUT: Values: 279.4 11:43:00 INFO - 2016-01-25 11:43:00,076 DEBUG : BROWSER_OUTPUT: 11:43:00 INFO - 2016-01-25 11:43:00,076 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5133.33 Median:5133.33 stddev:0.00 (0.0%) 11:43:00 INFO - 2016-01-25 11:43:00,076 DEBUG : BROWSER_OUTPUT: Values: 5133.3 11:43:00 INFO - 2016-01-25 11:43:00,076 DEBUG : BROWSER_OUTPUT: 11:43:00 INFO - 2016-01-25 11:43:00,077 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:925.93 Median:925.93 stddev:0.00 (0.0%) 11:43:00 INFO - 2016-01-25 11:43:00,077 DEBUG : BROWSER_OUTPUT: Values: 925.9 11:43:00 INFO - 2016-01-25 11:43:00,077 DEBUG : BROWSER_OUTPUT: 11:43:00 INFO - 2016-01-25 11:43:00,077 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:547.95 Median:547.95 stddev:0.00 (0.0%) 11:43:00 INFO - 2016-01-25 11:43:00,077 DEBUG : BROWSER_OUTPUT: Values: 547.9 11:43:00 INFO - 2016-01-25 11:43:00,077 DEBUG : BROWSER_OUTPUT: 11:43:00 INFO - 2016-01-25 11:43:00,077 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11021.74 Median:11021.74 stddev:0.00 (0.0%) 11:43:00 INFO - 2016-01-25 11:43:00,078 DEBUG : BROWSER_OUTPUT: Values: 11021.7 11:43:00 INFO - 2016-01-25 11:43:00,078 DEBUG : BROWSER_OUTPUT: 11:43:00 INFO - 2016-01-25 11:43:00,078 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:23809.52 Median:23809.52 stddev:0.00 (0.0%) 11:43:00 INFO - 2016-01-25 11:43:00,078 DEBUG : BROWSER_OUTPUT: Values: 23809.5 11:43:00 INFO - 2016-01-25 11:43:00,078 DEBUG : BROWSER_OUTPUT: 11:43:00 INFO - 2016-01-25 11:43:00,078 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:525.21 Median:525.21 stddev:0.00 (0.0%) 11:43:00 INFO - 2016-01-25 11:43:00,078 DEBUG : BROWSER_OUTPUT: Values: 525.2 11:43:00 INFO - 2016-01-25 11:43:00,079 DEBUG : BROWSER_OUTPUT: 11:43:00 INFO - 2016-01-25 11:43:00,079 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 11:43:00 INFO - 2016-01-25 11:43:00,079 DEBUG : BROWSER_OUTPUT: Values: 4830.9 11:43:00 INFO - 2016-01-25 11:43:00,079 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:43:00 INFO - 2016-01-25 11:43:00,079 DEBUG : BROWSER_OUTPUT: 11:43:00 INFO - 2016-01-25 11:43:00,900 INFO : Browser exited with error code: 0 11:43:00 INFO - 2016-01-25 11:43:00,917 INFO : Completed test v8_7 (00:00:39) 11:43:01 INFO - 2016-01-25 11:43:01,121 INFO : Completed test suite (00:20:07) 11:43:01 INFO - 2016-01-25 11:43:01,121 DEBUG : Working with test: dromaeo_css 11:43:01 INFO - 2016-01-25 11:43:01,121 DEBUG : Generating results file: dromaeo_css 11:43:01 INFO - 2016-01-25 11:43:01,122 DEBUG : Working with test: kraken 11:43:01 INFO - 2016-01-25 11:43:01,123 DEBUG : Generating results file: kraken 11:43:01 INFO - 2016-01-25 11:43:01,123 INFO : javascript benchmark 11:43:01 INFO - 2016-01-25 11:43:01,123 DEBUG : Working with test: v8_7 11:43:01 INFO - 2016-01-25 11:43:01,123 DEBUG : Generating results file: v8_7 11:43:01 INFO - 2016-01-25 11:43:01,123 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:43:01 INFO - 2016-01-25 11:43:01,173 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 11:43:01 INFO - 2016-01-25 11:43:01,173 DEBUG : process_Request line: dromaeo_css 7278.22 graph.html#tests=[[72,52,43]] 11:43:01 INFO - 2016-01-25 11:43:01,174 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:43:01 INFO - 2016-01-25 11:43:01,202 DEBUG : process_Request line: kraken 1501.30 graph.html#tests=[[232,52,43]] 11:43:01 INFO - 2016-01-25 11:43:01,202 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:43:01 INFO - 2016-01-25 11:43:01,231 DEBUG : process_Request line: v8_7 23231.08 graph.html#tests=[[230,52,43]] 11:43:01 INFO - 2016-01-25 11:43:01,233 INFO : javascript benchmark 11:43:01 INFO - 2016-01-25 11:43:01,236 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3233.9191520211994, 3271.6401195868466, 3281.442154833678, 3299.2411745298573, 3301.9834900825495, 5409.13453847384, 5429.294191755072, 5443.374011988622, 5444.346678398598, 5458.918116228259, 5515.531179849718, 5538.861528461791, 5545.3622833374175, 5557.3331200256025, 5584.664920104797, 4962.65261431699, 5034.521720436553, 5049.4950504949575, 5110.744462776846, 5131.589472842183, 4825.155597770394, 4987.351644286256, 4994.825181118662, 5006.224035274538, 5080.339555857752, 4977.800887964477, 5080.441151473354, 5080.441151473354, 5093.032323858473, 5166.17341225404, 5097.108006098936, 5128.666636668605, 5129.1024070787835, 5135.050015747099, 5153.587712982971, 4853.781579828917, 4888.9755551222015, 4950.777215025297, 5041.873953151164, 5059.2916991621205, 5365.356157261114, 5369.463053694639, 5420.376656684492, 5441.537469315073, 5449.155380915964, 5920.674362910038, 5978.641281523079, 6004.129401236796, 6027.819165425044, 6028.156058151862, 5794.5074668653215, 5896.174535565025, 5928.555358348098, 5976.103584462322, 6067.0, 5596.468335508161, 5602.859928501779, 5605.355384130837, 5626.437356264381, 5637.436256374371, 6087.482563982023, 6101.206843110367, 6102.633841969496, 6105.053716673922, 6109.908351374733, 5606.6916319602815, 5693.829185124453, 5709.486146246774, 5782.45066718661, 5832.912506312408, 5950.702464876739, 5966.985612445895, 5975.25309336333, 5976.970115149484, 5997.490213331828, 5899.321578018497, 5925.911111333334, 5930.1994230779155, 5939.2575928009, 5954.225950626477, 5678.716064196774, 5748.9712551437815, 5857.121431785266, 5965.254343207099, 5980.461758441761, 4577.382053422745, 4585.70192937458, 4591.632669386441, 4593.770311484413, 4612.262038073959, 3962.8612998544913, 4099.344104943195, 4109.547949725527, 4115.444415003936, 4121.155163191538, 5576.581756368289, 5594.1888426177975, 5635.633683810539, 5709.143628455765, 5727.140928860621, 5951.196588460589, 5981.850453738692, 6006.609570377911, 6026.5178785697035, 6039.335673075958, 5380.2736630555155, 5486.177073439016, 5582.302212223472, 5618.213450116987, 5664.745086471119, 5094.006668699568, 5181.974090129601, 5189.117849965515, 5196.662216955886, 5199.532042116228, 6184.134221209034, 6206.348333425016, 6211.3167551569295, 6224.439800417984, 6228.844278893064, 5758.165066065313, 5820.82537523858, 5878.823635290948, 6067.180930574316, 6071.301800293023, 6081.969590152198, 6127.6936153193055, 6137.101203255387, 6141.117811339906, 6144.402455361549, 5903.822885313448, 5959.344472107978, 5968.462838344396, 5969.3732158122775, 6007.519398448201, 5751.798687045934, 5856.12158176277, 6048.183495228088, 6049.3950604939155, 6079.3008803988105, 5719.771209151588, 5763.9135412968, 5774.509166720875, 5793.420657934173, 5821.301443826768, 5897.0, 5900.911486327623, 5903.940960590511, 5904.439078287556, 5932.466078052996, 5603.131514615241, 5644.717764111696, 5681.630694004876, 5712.11462223356, 5761.827145185651, 5901.7639294427745, 5921.792737254175, 5929.466348028698, 5942.286925568959, 5970.164177015308, 5708.57185711065, 5785.652860828363, 5812.157237200498, 5827.24245848037, 5832.183494310885], "unit": "ms", "name": "dojo.html", "value": 5482.851984355495}, {"lowerIsBetter": false, "replicates": [590.8611476303068, 632.5635311634973, 637.2830565613683, 639.8144538083956, 699.9675478668964, 31985.200369990762, 40409.59590404095, 40413.393799093, 40465.0, 40517.594824051754, 43134.13731725363, 43826.12347753043, 43848.780756096174, 43857.34213986793, 43898.78050609751, 8990.640374385017, 9061.50161741104, 9146.817063658722, 9153.67962121326, 9167.174954254117, 8665.566721663923, 8794.252488538483, 8807.867881981776, 8830.514321712304, 8841.778955526132, 8937.687180948667, 8939.329550283723, 8952.8657070144, 8987.191152796247, 9029.187373136416, 8935.329850261223, 8980.236679882251, 9009.954950225207, 9036.593353299051, 9049.140331668514, 8859.778505537348, 8936.955315223382, 9002.369834111614, 9009.909900900973, 9026.413283136575, 40754.796226018974, 40800.795996020126, 40979.7951010246, 41032.38451423231, 41253.381199282034, 3645.8177091145335, 3675.4119340905595, 3684.6315368463206, 3789.7347185697013, 4067.613576710208, 34357.312853742784, 34393.484097738554, 34450.483242751376, 34803.477947830805, 34953.300933981176, 3579.355715971124, 3589.623324069037, 3613.3134704406343, 3721.0325315418186, 3725.0873535983587, 299738.0, 302646.0, 302996.0, 303164.0, 304352.0, 48516.51483485191, 48810.26784598234, 69754.0, 70895.64552177206, 70947.2905270951, 64836.351636483974, 65237.021444678365, 65268.0, 65338.673306633165, 65380.34619653742, 16439.178041098137, 16591.668166636842, 16624.25190866414, 16680.916595416944, 16695.415660451825, 12610.49558017669, 12657.683557910941, 12783.23300601967, 12877.678058048436, 12996.935015324863, 21626.243081492074, 21846.344609661737, 21893.781062189493, 21895.452613684785, 21970.560588788456, 8613.181747733955, 8674.306055515544, 8697.521636310064, 8717.782055448664, 8787.428817126995, 946.2335508238349, 1035.2494441529982, 1040.99479502602, 1102.1293178389144, 1142.6914733022204, 28796.856015719786, 29545.0, 30084.24789380283, 32170.35659286801, 33822.323553529284, 1050.3067975136373, 1074.4803435942702, 1123.2698745815285, 1146.690393593725, 1198.4127777389017, 14991.575800298953, 15096.24518774057, 15373.077615343114, 15477.5356739298, 15522.611934701723, 815907.0, 858348.0, 867361.0, 867715.0, 868970.0, 59007.11489327664, 59009.40990590125, 59196.11205831916, 59471.405285947454, 59641.403585963584, 1300.8178854960313, 1306.732119915415, 1313.507434711983, 1321.5440672967811, 1365.3036951154982, 30029.54955675623, 30398.54402184013, 30582.0, 31225.37549248957, 31756.841215793775, 47879.281810773566, 48271.75864120657, 48380.516194837604, 48525.0, 48692.0, 320925.0, 322428.0, 322704.0, 324917.0, 325263.0, 32667.019989400356, 33132.1716957078, 33334.16664583405, 33420.164495887795, 33493.83253083817, 43532.78233608938, 43707.34438983354, 43827.12345753131, 43896.56103438925, 44343.556564433944, 37893.81053094717, 38398.424023640226, 39467.40798887962, 41733.58266417297, 45099.549004510845, 38874.6112538871, 39350.415946870635, 39358.0, 39622.0, 39822.0, 37965.684937958205, 38307.42538861975, 38762.6123738759, 38787.6121238784, 38836.0, 33657.0, 33893.0, 37617.0, 39783.80108099441, 43677.56322436862, 31943.18645552352, 32113.518297226026, 32158.678413216505, 32276.0, 32317.0], "unit": "ms", "name": "ext.html", "value": 20302.908559660766}, {"lowerIsBetter": false, "replicates": [374.859427714607, 376.1930658737011, 388.89694231028767, 391.46564938858455, 392.3584938625348, 15847.286872090755, 16891.746623800653, 17669.91165044173, 18651.72022419663, 18669.253229870807, 11072.169587280945, 11702.882971170307, 11720.472578733956, 11741.06071514279, 12075.094367922396, 4940.45654977953, 5034.647574669774, 5034.723090230036, 5051.848444546669, 5052.696838189702, 5065.645404821664, 5223.71269580173, 5323.973380133094, 5349.170878513836, 5379.919301210465, 5252.6323157379, 5329.893402131955, 5334.759935802898, 5680.630759000673, 5684.289463817023, 5670.744816483227, 5676.0, 5693.060644993592, 5698.287714035746, 5712.171735098429, 5309.601779866525, 5411.512963833274, 5431.158170483542, 5437.945620543784, 5446.645968012106, 13706.177629342272, 13760.793588096187, 13920.791188132187, 20147.496312592302, 20775.272865449788, 2102.611016961867, 2238.9104435822546, 2253.346529506441, 2261.31030035839, 2353.5410594933996, 9897.703068907944, 10007.249456290807, 10044.659564382111, 10348.223883208715, 10405.323653962469, 1917.2426891377827, 1917.7506924099916, 1930.3919265431343, 1936.7675878894481, 1973.1414200654028, 67745.66127169333, 70060.64969675119, 70741.64629176821, 71193.0, 73080.0, 11037.779244415067, 11197.944010279896, 11257.549698012152, 11260.98651121403, 11280.830787538194, 12470.501179952882, 14894.031887927467, 14906.329215185342, 14924.776128358084, 14947.775783363259, 7715.614219289013, 7840.803979900548, 8192.83614327722, 8216.671333146607, 8247.752567422987, 8076.4750291230885, 8092.878606820902, 8094.473859199134, 8111.716089936824, 8165.1426600207315, 4566.1552612766745, 4683.250679891201, 4683.297505374153, 4686.461056978423, 4867.561919427269, 1937.4962509747568, 1970.6157299326494, 1991.153759652142, 1996.5906989067207, 2007.6787713965987, 490.6663468841222, 491.15276148644017, 494.8935978764583, 926.5737760630051, 1104.0191482995942, 10920.0, 11096.1123110151, 11116.333020018825, 11284.887151128547, 11369.545218191344, 484.7842709994019, 885.420049867338, 962.3063408401264, 997.4937843855685, 1053.6786280184465, 7421.480496365202, 9463.858042129374, 9624.422534647943, 9630.662926797528, 9880.65417710391, 442075.0, 442281.78859105497, 444353.0, 450702.0, 566662.0, 85769.0, 88105.55947220222, 88504.0, 89279.55360223158, 91580.54209729042, 1154.7748189103213, 1161.5818305410046, 1170.8946194842506, 1198.9880101198876, 1204.8132539456399, 16057.598560036093, 16132.032078075354, 16230.594235143744, 16246.350145994027, 16260.51218463448, 36424.453633196055, 36745.44881826828, 36844.26311473809, 38308.80845595754, 38787.806060970644, 49543.0, 49583.0, 51590.484095158565, 52830.2075468876, 52863.0, 9873.45695986699, 10381.636642717469, 10498.580056797642, 10518.737031573966, 10547.57809687604, 16745.497635070966, 17816.0, 18061.909690451463, 18090.09549522545, 18369.081545922916, 14533.128012319296, 14535.127892326494, 14582.12507249526, 15253.694926101194, 15393.153376564396, 14475.348609312818, 15005.0, 15062.171580563174, 15209.77185342243, 15294.847051529343, 15002.474913377979, 15199.772003419735, 15201.0, 15586.532404027897, 15673.373065077269, 9908.504574771088, 10113.595456181965, 10145.28982971185, 10476.79046419052, 10486.26596138263, 12108.394580270775, 13515.797263041259, 14189.0, 15630.843691562939, 15720.76418853741], "unit": "ms", "name": "jquery.html", "value": 8908.447198438953}, {"lowerIsBetter": false, "replicates": [1691.6193856382313, 1713.4516954574538, 1808.7648605681259, 1863.1336428560726, 1863.329201487465, 7142.21435642079, 7487.064116985377, 7495.70017199312, 7683.346915512188, 7814.570198639072, 7827.178146294643, 7872.724454644089, 7938.40461965352, 7972.242636949495, 8020.558869262203, 2264.08304636622, 2306.527161931808, 2306.6770652108717, 2308.122913292946, 2308.4575124845646, 1911.5890083632016, 1914.5692219250627, 1917.7219303201027, 1934.303650685752, 1985.7517810273716, 2153.257126291427, 2180.1388451561625, 2204.9889750551224, 2255.391044418006, 2279.669447930049, 2278.5898538263104, 2295.1393227539675, 2322.3149170994598, 2328.7904088632104, 2333.463303440218, 2227.064632854189, 2240.9663855042186, 2246.247507085112, 2259.9661005084936, 2265.773422657721, 7802.804929876742, 7804.141544430108, 7804.531728096333, 7847.5291482510665, 7864.68541258349, 4631.258998560248, 4656.976715116437, 4709.317149013408, 4732.313814496879, 4749.857504274877, 2934.5158048921903, 2995.970040299591, 3000.4599172149005, 3003.609530761009, 3024.3497648005564, 935.2658163341744, 949.4493193947563, 964.5563041001147, 971.6307803034802, 983.6409710455704, 10308.381497110197, 10370.740731481697, 10375.169986401146, 10409.0, 10418.27072104953, 3999.8600048998146, 4039.414284928669, 4075.347944328893, 4109.301418758818, 4127.711060225755, 8524.914750852537, 8557.400981931329, 8649.481031138152, 8650.74047778555, 8676.392652514263, 4502.302143167814, 4557.361969324297, 4564.292534657067, 4578.9771051144535, 4597.0, 4191.036061705825, 4210.368444733253, 4215.409842622035, 4234.280172370704, 4241.724287921275, 3273.4598791199187, 3312.1222875937897, 3320.6513316101946, 3324.1523411529906, 3346.247094403788, 996.4519514267124, 997.7605374710017, 1000.6747806962766, 1007.1288335589809, 1023.9692809215735, 1179.9941000294943, 1197.26368283505, 1237.5173682263924, 1459.3724698379585, 1477.1137317609564, 6827.283135270725, 6834.6582670866255, 6970.233274339818, 6986.336298051677, 6998.230194678581, 1179.0685358566807, 1182.1429463638792, 1187.4597058338436, 1191.666333426642, 1215.0947544079718, 5843.065109582446, 5845.707714614252, 5868.354481007086, 5915.319738230072, 5944.613600115978, 8662.393632445668, 9053.59258833354, 9059.867516560429, 9063.54682265884, 9194.12655797698, 8896.555172241362, 8954.641814327484, 9013.233875120688, 9071.183593476619, 9095.772605684911, 7097.503174777819, 7131.42948564124, 7212.4590655699985, 7212.891806622905, 7258.3104605062435, 7071.504994650325, 7141.535800172972, 7151.749688760869, 7199.748008819875, 7213.20654727969, 7887.526748395115, 7897.723579674684, 7989.121196668478, 8130.146334634778, 8138.87791683137, 8246.340292776684, 8253.09215986229, 8265.0, 8271.710490132817, 8285.088640249447, 6704.463642908653, 6833.69248383814, 6879.58722476653, 6888.276730943179, 6914.412274956685, 7328.303811137934, 7384.446166537424, 7417.851642967003, 7420.369268612012, 7437.293457121565, 6607.702653380706, 7153.570785752871, 7303.123625165014, 7373.926260737324, 7385.409167266498, 6628.83427914306, 6679.799606011828, 6681.699323530355, 6682.097916781367, 6981.755638552626, 6912.412444942236, 6985.0, 7006.054182685272, 7059.5058345915295, 7061.682224299816, 6451.677416129269, 6488.221413430419, 6503.577267477599, 6507.73969041252, 6508.869822603616, 6314.936850631435, 6423.004434312689, 6471.320511346429, 6671.666416679243, 6681.0], "unit": "ms", "name": "mootools.html", "value": 4419.2291797586695}, {"lowerIsBetter": false, "replicates": [335.88076232937306, 351.3219486391264, 352.37629395969117, 352.413231968772, 354.459449339757, 6347.777827776017, 6356.61860288383, 6387.616742995418, 6468.32082631324, 6484.740610375585, 6175.783847565336, 6329.620222786636, 6341.619502829833, 6364.0, 6370.649614271213, 4815.783289751952, 4834.178189707741, 4843.58829499493, 4848.903021939568, 4855.101806165853, 4839.080574690815, 4844.2733589961435, 4850.223964165734, 4857.562819346258, 4868.148074087038, 4612.746298953573, 4824.083424149418, 4833.154198015351, 4849.108847549459, 4850.563449289563, 4776.617870570346, 4787.210110331791, 4797.136515427222, 4798.5441383068555, 4808.302796094564, 4207.768572728499, 4217.472815898012, 4219.07180420307, 4222.809973551167, 4229.069604686964, 5922.318933322636, 5998.8500287492725, 6003.129546215818, 6005.54958378119, 6007.729652165663, 5593.440655934374, 5603.2435621191435, 5605.523530499912, 5605.831825045255, 5617.578681598897, 6643.900341494881, 6682.498812589075, 6686.197656281229, 6690.698918548628, 6698.531102822804, 4656.720596764171, 4663.743494107823, 4665.976670116662, 4666.53334666534, 4680.555347242007, 6901.896471552931, 6971.965140174318, 6998.335158159966, 7008.649567521604, 7012.719491220345, 4749.881252968635, 4770.379850619467, 4771.212749896297, 4772.284157376352, 4776.402949631296, 4810.037992401533, 4827.61379089672, 4833.879153021132, 4843.515648435199, 4857.441394239637, 5488.847342058212, 5587.329520457572, 5595.972020139873, 5601.075822489325, 5601.215829783833, 6717.261101278856, 6732.158480189976, 6752.898706519406, 6761.763338283136, 6766.72933082681, 1675.1875340459867, 1721.0792226158944, 1726.8100508944005, 1730.108993868159, 1730.9740353894701, 1110.0675432636463, 1157.1899670230873, 1169.2399940038872, 1176.864660564046, 1184.6090790039439, 6476.708548115346, 6480.708368123445, 6487.18910136233, 6487.2539657939, 6487.286398496161, 6890.93109068913, 6908.516403851782, 6923.065386172903, 6928.757493487704, 6930.757423490154, 6330.746770129235, 6443.871122577522, 6461.547691661633, 6467.902981455282, 6492.610443373413, 3757.868474603376, 3776.546814382237, 3785.564660064073, 3786.110264087937, 3795.7153213508545, 7084.92915070853, 7090.397316228075, 7137.4290056795335, 7141.143062832493, 7147.8570428592175, 7074.3633073023675, 7080.433565314763, 7085.43316534676, 7117.501774875813, 7352.595607241653, 7298.051253337138, 7323.853522929511, 7324.157721861948, 7327.890081648779, 7341.265873412616, 7106.538075025107, 7107.147142342952, 7111.964440177973, 7121.323474270143, 7130.857382852418, 6863.485238607024, 6935.271796461299, 6979.720811167496, 6986.685599147949, 6995.615241161785, 7345.816354591178, 7382.926170738224, 7385.261473852572, 7385.781346077837, 7386.0767404074495, 4788.952110478851, 4804.615630749462, 4816.735079570517, 4819.638527110411, 4820.373351464287, 6961.6519174042105, 6963.547369421174, 7042.401395881408, 7104.431645468247, 7110.075690160246, 6857.211420686485, 6886.139232595926, 6889.862202756017, 6896.517243792886, 6917.9654101731185, 6865.862682746218, 6874.381305682513, 6907.861842763016, 6908.930910690829, 6910.585364878123, 6515.120458738199, 6686.498512611671, 6706.362895524917, 6717.697703603252, 6766.15423072116, 6809.012693159365, 6914.0666010088, 6920.9653951729915, 6937.132858392701, 6941.34057264559, 6717.227518835201, 6773.085633439423, 6775.457963362821, 6779.423748981195, 6794.8641027180165], "unit": "ms", "name": "prototype.html", "value": 5102.80928227262}, {"lowerIsBetter": false, "replicates": [776.9922300776991, 835.4653022065875, 842.4734540911934, 847.4449235750583, 863.9092895245999, 13727.176369417843, 13931.930340348285, 13948.79076813846, 14036.228007459586, 14048.64878378041, 14093.154410735364, 14220.857791422082, 14325.92837035816, 14382.065165764217, 14679.706405871877, 874.1258741258741, 883.9469631822079, 891.7369376034053, 897.9551022448884, 902.4900930974012, 849.1762989899787, 852.3096292003466, 852.654674856684, 857.3998201259112, 857.4169564696004, 934.5934518484447, 935.4200395754642, 942.3026960049548, 943.3019565521499, 945.1729736480579, 933.276710549323, 933.5239028095687, 934.7055677461645, 935.5369092299321, 936.5457752989761, 695.0824911117327, 711.249631638621, 715.4026387966055, 715.613568672916, 717.4081382859162, 15122.319495622723, 15145.0, 15220.086794792238, 15220.771688424682, 15256.771148432783, 12595.433205505775, 12671.61985140438, 12888.097833151684, 13045.34773261333, 13469.063432332357, 10491.38570071094, 10602.522886470128, 10678.199135064824, 10693.19801014927, 10846.078083362845, 3358.899233023013, 3397.1507123219194, 3422.144463884029, 3425.2978139481347, 3426.3489936911906, 51806.74096629531, 51860.0, 52035.47964520344, 52220.21669674958, 52393.0, 10233.846492302622, 10397.777998214402, 10487.685369438928, 10551.788964220672, 10786.406747628798, 19149.04254787283, 19362.322318718776, 19378.0, 19408.708869366972, 19414.12636431364, 7768.378529717609, 7780.688772449039, 7806.1413244543055, 7884.211578842184, 7918.049834019839, 4501.122281155209, 4507.166174257773, 4596.701214421052, 4644.674872758875, 4752.168370535212, 3241.5623890774445, 3283.1627934876456, 3294.2423242653845, 3317.817520036373, 3324.750643701732, 544.335910189568, 547.6960287040731, 547.7452984362211, 548.4844246408363, 552.9336479622391, 608.6074481959112, 659.9208095028531, 713.2403989750899, 724.3625609463744, 726.7347418192322, 8809.911900881038, 8883.067277935723, 9116.361854670242, 9220.861687074565, 9305.813883722423, 656.4125108028288, 674.8717743628695, 749.3667850666287, 751.1099347273498, 768.2202564397141, 4411.955880441219, 4630.745309008037, 4673.906521869543, 4679.906401871944, 4691.5308469152815, 62177.68911155415, 62790.37209627845, 62923.0, 63040.369596304365, 63589.68205158944, 54940.45059549433, 55665.72167139138, 56224.71887640536, 56353.0, 56563.71718141383, 49703.75148124236, 49850.501494985314, 49905.0, 50789.98420031579, 50935.23597146046, 8525.19010694008, 8622.137786221328, 8747.60635771379, 8859.24696400813, 9031.36780425364, 36203.0, 36823.0, 37573.62426375701, 37777.62222377851, 37802.62197377991, 42702.57297426986, 45756.0, 48350.5164948346, 48495.27257091217, 49016.0, 9252.074792520963, 10471.057604815604, 10613.257072004886, 10919.39943303126, 11255.437228138724, 12143.39283035827, 12450.377481126088, 12458.127931044739, 12585.370731463574, 12606.432710528232, 11812.70468238301, 12062.819057714318, 12102.636920892388, 12617.242965422103, 12629.2422454653, 11304.886951130713, 11374.260673056226, 11430.085593152695, 11661.06711463064, 11806.645800625995, 10659.307145035547, 10783.568657253621, 10924.235303528994, 10970.945145274223, 11338.263012904135, 9270.490123043297, 9614.807703846023, 9664.468454235084, 9752.122308992224, 9859.901400985898, 9308.208802251613, 9336.579853906725, 9862.950685246527, 9897.109260166619, 9904.108630223314], "unit": "ms", "name": "yui.html", "value": 6646.443113320964}], "name": "dromaeo_css", "value": 7278.222552859166}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 106.0, 111.0, 111.0, 113.0, 121.0, 113.0, 111.0, 111.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 112.2}, {"lowerIsBetter": true, "replicates": [143.0, 133.0, 152.0, 154.0, 125.0, 155.0, 148.0, 129.0, 158.0, 123.0], "unit": "ms", "name": "audio-beat-detection", "value": 142.0}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 162.0, 162.0, 162.0, 160.0, 160.0, 160.0, 164.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 161.6}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 72.0, 160.0, 72.0, 72.0, 70.0, 71.0, 160.0, 75.0], "unit": "ms", "name": "audio-fft", "value": 89.7}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 136.0, 94.0, 93.0, 92.0, 138.0, 92.0, 92.0, 134.0], "unit": "ms", "name": "audio-oscillator", "value": 105.6}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 109.0, 110.0, 111.0, 110.0, 109.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 147.0, 147.0, 148.0, 147.0, 146.0, 146.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 96.0, 95.0, 96.0, 97.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [56.0, 59.0, 57.0, 58.0, 57.0, 58.0, 60.0, 57.0, 60.0, 56.0], "unit": "ms", "name": "json-parse-financial", "value": 57.8}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 64.0, 64.0, 64.0, 64.0, 63.0, 63.0, 64.0, 63.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 63.6}, {"lowerIsBetter": true, "replicates": [79.0, 82.0, 82.0, 83.0, 89.0, 81.0, 84.0, 82.0, 80.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 82.6}, {"lowerIsBetter": true, "replicates": [119.0, 113.0, 111.0, 120.0, 115.0, 111.0, 128.0, 119.0, 119.0, 125.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 118.0}, {"lowerIsBetter": true, "replicates": [154.0, 149.0, 155.0, 149.0, 149.0, 148.0, 152.0, 139.0, 153.0, 147.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 149.5}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 65.0, 65.0, 66.0, 64.0, 68.0, 65.0, 72.0, 65.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.3}], "name": "kraken", "value": 1501.2999999999997}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.84155756965424], "unit": "score", "name": "Richards", "value": 210.32931599999992}, {"lowerIsBetter": false, "replicates": [167.1402306535183], "unit": "score", "name": "DeltaBlue", "value": 395.58399399999996}, {"lowerIsBetter": false, "replicates": [279.4076557697681], "unit": "score", "name": "Encrypt", "value": 952.6617989999997}, {"lowerIsBetter": false, "replicates": [5133.333333333333], "unit": "score", "name": "Decrypt", "value": 51.85344155844158}, {"lowerIsBetter": false, "replicates": [925.925925925926], "unit": "score", "name": "RayTrace", "value": 799.1881199999998}, {"lowerIsBetter": false, "replicates": [547.945205479452], "unit": "score", "name": "Earley", "value": 1216.2949749999998}, {"lowerIsBetter": false, "replicates": [11021.739130434782], "unit": "score", "name": "Boyer", "value": 60.468043392504924}, {"lowerIsBetter": false, "replicates": [23809.52380952381], "unit": "score", "name": "RegExp", "value": 38.26136999999999}, {"lowerIsBetter": false, "replicates": [525.2100840336135], "unit": "score", "name": "Splay", "value": 155.15886400000005}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 23231.076199576477}]} 11:43:01 INFO - RETURN: dromaeo_css: 7278.22 11:43:01 INFO - RETURN: kraken: 1501.30 11:43:01 INFO - RETURN: v8_7: 23231.08 11:43:01 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "23231.08"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1501.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7278.22"}}} 11:43:01 INFO - Return code: 0 11:43:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:43:01 INFO - # TBPL SUCCESS # 11:43:01 INFO - Running post-action listener: _resource_record_post_action 11:43:01 INFO - Running post-run listener: _resource_record_post_run 11:43:02 INFO - Total resource usage - Wall time: 1223s; CPU: 13.0%; Read bytes: 12288; Write bytes: 511418368; Read time: 88; Write time: 338252 11:43:02 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 4096; Write bytes: 246136832; Read time: 60; Write time: 197160 11:43:02 INFO - run-tests - Wall time: 1209s; CPU: 13.0%; Read bytes: 8192; Write bytes: 265281536; Read time: 28; Write time: 141092 11:43:02 INFO - Running post-run listener: _upload_blobber_files 11:43:02 INFO - Blob upload gear active. 11:43:02 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 11:43:02 INFO - Copying logs to upload dir... 11:43:02 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1262.241732 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-01-25 11:43:02.410489) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-25 11:43:02.413789) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1453749718.621086-22118459 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.010103 build_url: 'https://queue.taskcluster.net/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-25 11:43:02.465770) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:43:02.466091) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1453749718.621086-22118459 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004602 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:43:02.515947) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 11:43:02.516271) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 11:43:02.516561) ========= ========= Total master_lag: 0.31 =========