builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-004 starttime: 1450128746.01 results: success (0) buildid: 20151214121624 builduid: 21b2b619eee1449f9900fe31dc6f86db revision: 06ab805e14b5e6d8a8a99c7846c8fde163a9e5d7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-14 13:32:26.013028) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-14 13:32:26.013518) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-14 13:32:26.013832) ========= bash -c pwd in dir /builds/slave/test/. (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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8e92d6ac3b8b0dffa3775d33000001f9-1450128745.803361-117896578 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006178 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-14 13:32:26.036444) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-14 13:32:26.036753) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-14 13:32:26.050153) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 13:32:26.050537) ========= rm -rf properties in dir /builds/slave/test/. (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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8e92d6ac3b8b0dffa3775d33000001f9-1450128745.803361-117896578 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004535 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 13:32:26.099490) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-14 13:32:26.099810) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-14 13:32:26.100264) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 13:32:26.100554) ========= 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/. (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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8e92d6ac3b8b0dffa3775d33000001f9-1450128745.803361-117896578 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-14 13:32:26-- 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% 47.3M=0s 2015-12-14 13:32:26 (47.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.167919 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 13:32:26.280740) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 13:32:26.281048) ========= rm -rf scripts in dir /builds/slave/test/. (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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8e92d6ac3b8b0dffa3775d33000001f9-1450128745.803361-117896578 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017092 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 13:32:26.330298) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 13:32:26.330656) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 06ab805e14b5e6d8a8a99c7846c8fde163a9e5d7 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 06ab805e14b5e6d8a8a99c7846c8fde163a9e5d7 --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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8e92d6ac3b8b0dffa3775d33000001f9-1450128745.803361-117896578 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-14 13:32:26,792 truncating revision to first 12 chars 2015-12-14 13:32:26,792 Setting DEBUG logging. 2015-12-14 13:32:26,792 attempt 1/10 2015-12-14 13:32:26,792 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/06ab805e14b5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-14 13:32:27,053 unpacking tar archive at: mozilla-central-06ab805e14b5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.566444 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 13:32:26.909997) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-14 13:32:26.910316) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-14 13:32:26.918018) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-14 13:32:26.918471) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-14 13:32:26.918968) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2015-12-14 13:32:26.919283) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (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', 'Firefox-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8e92d6ac3b8b0dffa3775d33000001f9-1450128745.803361-117896578 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:32:27 INFO - MultiFileLogger online at 20151214 13:32:27 in /builds/slave/test 13:32:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 13:32:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:32:27 INFO - {'append_to_log': False, 13:32:27 INFO - 'base_work_dir': '/builds/slave/test', 13:32:27 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 13:32:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:32:27 INFO - 'branch': 'Firefox-Non-PGO', 13:32:27 INFO - 'buildbot_json_path': 'buildprops.json', 13:32:27 INFO - 'config_files': ('talos/linux_config.py',), 13:32:27 INFO - 'default_actions': ('clobber', 13:32:27 INFO - 'read-buildbot-config', 13:32:27 INFO - 'download-and-extract', 13:32:27 INFO - 'populate-webroot', 13:32:27 INFO - 'create-virtualenv', 13:32:27 INFO - 'install', 13:32:27 INFO - 'run-tests'), 13:32:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:32:27 INFO - 'download_minidump_stackwalk': True, 13:32:27 INFO - 'download_symbols': 'ondemand', 13:32:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:32:27 INFO - 'tooltool.py': '/tools/tooltool.py', 13:32:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:32:27 INFO - '/tools/misc-python/virtualenv.py')}, 13:32:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:32:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:32:27 INFO - 'installer_path': 'installer.exe', 13:32:27 INFO - 'log_level': 'info', 13:32:27 INFO - 'log_name': 'talos', 13:32:27 INFO - 'log_to_console': True, 13:32:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:32:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:32:27 INFO - 'opt_config_files': (), 13:32:27 INFO - 'pip_index': False, 13:32:27 INFO - 'sps_profile': False, 13:32:27 INFO - 'sps_profile_interval': 0, 13:32:27 INFO - 'suite': 'dromaeojs-e10s', 13:32:27 INFO - 'system_bits': '64', 13:32:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:32:27 INFO - 'title': 'talos-linux64-ix-004', 13:32:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:32:27 INFO - 'use_talos_json': True, 13:32:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:32:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:32:27 INFO - 'work_dir': 'build'} 13:32:27 INFO - ##### 13:32:27 INFO - ##### Running clobber step. 13:32:27 INFO - ##### 13:32:27 INFO - Running pre-action listener: _resource_record_pre_action 13:32:27 INFO - Running main action method: clobber 13:32:27 INFO - rmtree: /builds/slave/test/build 13:32:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:32:27 INFO - Running post-action listener: _resource_record_post_action 13:32:27 INFO - ##### 13:32:27 INFO - ##### Running read-buildbot-config step. 13:32:27 INFO - ##### 13:32:27 INFO - Running pre-action listener: _resource_record_pre_action 13:32:27 INFO - Running main action method: read_buildbot_config 13:32:27 INFO - Using buildbot properties: 13:32:27 INFO - { 13:32:27 INFO - "properties": { 13:32:27 INFO - "buildnumber": 145, 13:32:27 INFO - "product": "firefox", 13:32:27 INFO - "script_repo_revision": "production", 13:32:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 13:32:27 INFO - "repository": "", 13:32:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 13:32:27 INFO - "buildid": "20151214121624", 13:32:27 INFO - "slavename": "talos-linux64-ix-004", 13:32:27 INFO - "pgo_build": "False", 13:32:27 INFO - "basedir": "/builds/slave/test", 13:32:27 INFO - "project": "", 13:32:27 INFO - "platform": "ubuntu64_hw", 13:32:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:32:27 INFO - "slavebuilddir": "test", 13:32:27 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 13:32:27 INFO - "branch": "mozilla-central", 13:32:27 INFO - "repo_path": "mozilla-central", 13:32:27 INFO - "stage_platform": "linux64", 13:32:27 INFO - "builduid": "21b2b619eee1449f9900fe31dc6f86db", 13:32:27 INFO - "revision": "06ab805e14b5e6d8a8a99c7846c8fde163a9e5d7" 13:32:27 INFO - }, 13:32:27 INFO - "sourcestamp": { 13:32:27 INFO - "repository": "", 13:32:27 INFO - "hasPatch": false, 13:32:27 INFO - "project": "", 13:32:27 INFO - "branch": "mozilla-central-linux64-talos", 13:32:27 INFO - "changes": [ 13:32:27 INFO - { 13:32:27 INFO - "category": null, 13:32:27 INFO - "files": [ 13:32:27 INFO - { 13:32:27 INFO - "url": null, 13:32:27 INFO - "name": "https://queue.taskcluster.net/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2" 13:32:27 INFO - } 13:32:27 INFO - ], 13:32:27 INFO - "repository": "", 13:32:27 INFO - "rev": "06ab805e14b5e6d8a8a99c7846c8fde163a9e5d7", 13:32:27 INFO - "who": "raliiev@mozilla.com", 13:32:27 INFO - "when": 1450128613, 13:32:27 INFO - "number": 7358540, 13:32:27 INFO - "comments": "Update configs. IGNORE BROKEN CHANGESETS CLOSED TREE NO BUG a=release ba=release", 13:32:27 INFO - "project": "", 13:32:27 INFO - "at": "Mon 14 Dec 2015 13:30:13", 13:32:27 INFO - "branch": "mozilla-central-linux64-talos", 13:32:27 INFO - "revlink": "", 13:32:27 INFO - "properties": [ 13:32:27 INFO - [ 13:32:27 INFO - "buildid", 13:32:27 INFO - "20151214121624", 13:32:27 INFO - "Change" 13:32:27 INFO - ], 13:32:27 INFO - [ 13:32:27 INFO - "builduid", 13:32:27 INFO - "21b2b619eee1449f9900fe31dc6f86db", 13:32:27 INFO - "Change" 13:32:27 INFO - ], 13:32:27 INFO - [ 13:32:27 INFO - "pgo_build", 13:32:27 INFO - "False", 13:32:27 INFO - "Change" 13:32:27 INFO - ] 13:32:27 INFO - ], 13:32:27 INFO - "revision": "06ab805e14b5e6d8a8a99c7846c8fde163a9e5d7" 13:32:27 INFO - } 13:32:27 INFO - ], 13:32:27 INFO - "revision": "06ab805e14b5e6d8a8a99c7846c8fde163a9e5d7" 13:32:27 INFO - } 13:32:27 INFO - } 13:32:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 13:32:27 INFO - Running post-action listener: _resource_record_post_action 13:32:27 INFO - ##### 13:32:27 INFO - ##### Running download-and-extract step. 13:32:27 INFO - ##### 13:32:27 INFO - Running pre-action listener: _resource_record_pre_action 13:32:27 INFO - Running main action method: download_and_extract 13:32:27 INFO - mkdir: /builds/slave/test/build/tests 13:32:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:27 INFO - https://queue.taskcluster.net/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 13:32:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/test_packages.json 13:32:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/test_packages.json 13:32:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 13:32:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 13:32:28 INFO - Downloaded 1302 bytes. 13:32:28 INFO - Reading from file /builds/slave/test/build/test_packages.json 13:32:28 INFO - Using the following test package requirements: 13:32:28 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:32:28 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:32:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:32:28 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:32:28 INFO - u'jsshell-linux-x86_64.zip'], 13:32:28 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:32:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:32:28 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:32:28 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:32:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:32:28 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:32:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:32:28 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:32:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:32:28 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:32:28 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:32:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:32:28 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:32:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:28 INFO - https://queue.taskcluster.net/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:32:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:32:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:32:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:32:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:32:29 INFO - Downloaded 21869726 bytes. 13:32:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 13:32:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:32:29 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 13:32:30 INFO - Return code: 0 13:32:30 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:32:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:30 INFO - https://queue.taskcluster.net/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:32:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:32:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:32:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:32:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:32:31 INFO - Downloaded 21869726 bytes. 13:32:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 13:32:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:32:31 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 13:32:33 INFO - Return code: 0 13:32:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:33 INFO - https://queue.taskcluster.net/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:32:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:32:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:32:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:32:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:32:34 INFO - Downloaded 11132038 bytes. 13:32:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 13:32:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:32:34 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 13:32:34 INFO - Return code: 0 13:32: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')]} 13:32:34 INFO - https://queue.taskcluster.net/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:32:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:32:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:32:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:32:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:32:35 INFO - Downloaded 57740753 bytes. 13:32:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:32:35 INFO - mkdir: /builds/slave/test/properties 13:32:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:32:35 INFO - Writing to file /builds/slave/test/properties/build_url 13:32:35 INFO - Contents: 13:32:35 INFO - build_url:https://queue.taskcluster.net/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:32:35 INFO - Running post-action listener: _resource_record_post_action 13:32:35 INFO - Running post-action listener: set_extra_try_arguments 13:32:35 INFO - ##### 13:32:35 INFO - ##### Running populate-webroot step. 13:32:35 INFO - ##### 13:32:35 INFO - Running pre-action listener: _resource_record_pre_action 13:32:35 INFO - Running main action method: populate_webroot 13:32:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:32:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:32:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:32:35 INFO - '--tppagecycles', 13:32:35 INFO - '7'], 13:32:35 INFO - 'tests': ['tsvgm']}}, 13:32:35 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:32:35 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:32:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:32:35 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:32:35 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:32:35 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:32:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:32:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:32:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:32:35 INFO - 'talos_options': ['--e10s'], 13:32:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:32:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:32:35 INFO - 'tests': ['damp', 'tps']}, 13:32:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:32:35 INFO - 'talos_options': ['--e10s'], 13:32:35 INFO - 'tests': ['damp', 'tps']}, 13:32:35 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:32:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:32:35 INFO - 'other': {'tests': ['a11yr', 13:32:35 INFO - 'ts_paint', 13:32:35 INFO - 'tpaint', 13:32:35 INFO - 'sessionrestore', 13:32:35 INFO - 'sessionrestore_no_auto_restore']}, 13:32:35 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:32:35 INFO - 'tests': ['a11yr', 13:32:35 INFO - 'ts_paint', 13:32:35 INFO - 'tpaint', 13:32:35 INFO - 'sessionrestore', 13:32:35 INFO - 'sessionrestore_no_auto_restore']}, 13:32:35 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:32:35 INFO - 'tests': ['a11yr', 13:32:35 INFO - 'ts_paint', 13:32:35 INFO - 'tpaint', 13:32:35 INFO - 'sessionrestore', 13:32:35 INFO - 'sessionrestore_no_auto_restore']}, 13:32:35 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:32:35 INFO - 'tests': ['a11yr', 13:32:35 INFO - 'ts_paint', 13:32:35 INFO - 'tpaint', 13:32:35 INFO - 'sessionrestore', 13:32:35 INFO - 'sessionrestore_no_auto_restore']}, 13:32:35 INFO - 'other_l64': {'tests': ['a11yr', 13:32:35 INFO - 'ts_paint', 13:32:35 INFO - 'tpaint', 13:32:35 INFO - 'sessionrestore', 13:32:35 INFO - 'sessionrestore_no_auto_restore']}, 13:32:35 INFO - 'other_nol64': {'tests': ['a11yr', 13:32:35 INFO - 'ts_paint', 13:32:35 INFO - 'tpaint', 13:32:35 INFO - 'sessionrestore', 13:32:35 INFO - 'sessionrestore_no_auto_restore']}, 13:32:35 INFO - 'svgr': {'tests': ['tsvgx', 13:32:35 INFO - 'tsvgr_opacity', 13:32:35 INFO - 'tart', 13:32:35 INFO - 'tscrollx', 13:32:35 INFO - 'cart']}, 13:32:35 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:32:35 INFO - 'tests': ['tsvgx', 13:32:35 INFO - 'tsvgr_opacity', 13:32:35 INFO - 'tart', 13:32:35 INFO - 'tscrollx', 13:32:35 INFO - 'cart']}, 13:32:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:32:35 INFO - 'tests': ['tp5o']}, 13:32:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:32:35 INFO - 'talos_options': ['--e10s'], 13:32:35 INFO - 'tests': ['tp5o']}, 13:32:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:32:35 INFO - 'talos_options': ['--xperf_path', 13:32:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:32:35 INFO - 'tests': ['tp5n']}, 13:32:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:32:35 INFO - 'talos_options': ['--e10s', 13:32:35 INFO - '--xperf_path', 13:32:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:32:35 INFO - 'tests': ['tp5n']}}, 13:32:35 INFO - 'talos.zip': {'path': '', 13:32:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:32:35 INFO - Running post-action listener: _resource_record_post_action 13:32:35 INFO - ##### 13:32:35 INFO - ##### Running create-virtualenv step. 13:32:35 INFO - ##### 13:32:35 INFO - Running pre-action listener: _resource_record_pre_action 13:32:35 INFO - Running main action method: create_virtualenv 13:32:35 INFO - Creating virtualenv /builds/slave/test/build/venv 13:32:35 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:32:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:32:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:32:35 INFO - Using real prefix '/usr' 13:32:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:32:36 INFO - Installing distribute.............................................................................................................................................................................................done. 13:32:38 INFO - Installing pip.................done. 13:32:38 INFO - Return code: 0 13:32:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:32:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fb2bfc8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x223d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239a0b0>, '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 0x239afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239b440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1450128745.803361-117896578', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:32:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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/build 13:32:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:32:38 INFO - Using env: {'DISPLAY': ':0', 13:32:38 INFO - 'HOME': '/home/cltbld', 13:32:38 INFO - 'LANG': 'en_US.UTF-8', 13:32:38 INFO - 'LANGUAGE': 'en_US:en', 13:32:38 INFO - 'LOGNAME': 'cltbld', 13:32:38 INFO - 'MAIL': '/var/mail/cltbld', 13:32:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:38 INFO - 'MOZ_NO_REMOTE': '1', 13:32:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:38 INFO - 'NO_EM_RESTART': '1', 13:32:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:38 INFO - 'PWD': '/builds/slave/test', 13:32:38 INFO - 'SHELL': '/bin/bash', 13:32:38 INFO - 'SHLVL': '1', 13:32:38 INFO - 'TERM': 'linux', 13:32:38 INFO - 'TMOUT': '86400', 13:32:38 INFO - 'USER': 'cltbld', 13:32:38 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1450128745.803361-117896578', 13:32:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:38 INFO - '_': '/tools/buildbot/bin/python'} 13:32:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:38 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 13:32:38 INFO - Cleaning up... 13:32:38 INFO - Return code: 0 13:32:38 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:32:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fb2bfc8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x223d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239a0b0>, '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 0x239afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239b440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1450128745.803361-117896578', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:32:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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/build 13:32:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 13:32:38 INFO - Using env: {'DISPLAY': ':0', 13:32:38 INFO - 'HOME': '/home/cltbld', 13:32:38 INFO - 'LANG': 'en_US.UTF-8', 13:32:38 INFO - 'LANGUAGE': 'en_US:en', 13:32:38 INFO - 'LOGNAME': 'cltbld', 13:32:38 INFO - 'MAIL': '/var/mail/cltbld', 13:32:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:38 INFO - 'MOZ_NO_REMOTE': '1', 13:32:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:38 INFO - 'NO_EM_RESTART': '1', 13:32:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:38 INFO - 'PWD': '/builds/slave/test', 13:32:38 INFO - 'SHELL': '/bin/bash', 13:32:38 INFO - 'SHLVL': '1', 13:32:38 INFO - 'TERM': 'linux', 13:32:38 INFO - 'TMOUT': '86400', 13:32:38 INFO - 'USER': 'cltbld', 13:32:38 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1450128745.803361-117896578', 13:32:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:38 INFO - '_': '/tools/buildbot/bin/python'} 13:32:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:38 INFO - Downloading/unpacking psutil>=0.7.1 13:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:40 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 13:32:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 13:32:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:32:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:32:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:32:40 INFO - Installing collected packages: psutil 13:32:40 INFO - Running setup.py install for psutil 13:32:40 INFO - building 'psutil._psutil_linux' extension 13:32:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 13:32:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 13:32:40 INFO - building 'psutil._psutil_posix' extension 13:32:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 13:32:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 13:32:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:32:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:32:41 INFO - Successfully installed psutil 13:32:41 INFO - Cleaning up... 13:32:41 INFO - Return code: 0 13:32:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:32:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fb2bfc8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x223d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239a0b0>, '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 0x239afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239b440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1450128745.803361-117896578', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:32:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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/build 13:32:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 13:32:41 INFO - Using env: {'DISPLAY': ':0', 13:32:41 INFO - 'HOME': '/home/cltbld', 13:32:41 INFO - 'LANG': 'en_US.UTF-8', 13:32:41 INFO - 'LANGUAGE': 'en_US:en', 13:32:41 INFO - 'LOGNAME': 'cltbld', 13:32:41 INFO - 'MAIL': '/var/mail/cltbld', 13:32:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:41 INFO - 'MOZ_NO_REMOTE': '1', 13:32:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:41 INFO - 'NO_EM_RESTART': '1', 13:32:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:41 INFO - 'PWD': '/builds/slave/test', 13:32:41 INFO - 'SHELL': '/bin/bash', 13:32:41 INFO - 'SHLVL': '1', 13:32:41 INFO - 'TERM': 'linux', 13:32:41 INFO - 'TMOUT': '86400', 13:32:41 INFO - 'USER': 'cltbld', 13:32:41 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1450128745.803361-117896578', 13:32:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:41 INFO - '_': '/tools/buildbot/bin/python'} 13:32:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:41 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:32:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:32:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 13:32:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:32:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:32:43 INFO - Installing collected packages: mozsystemmonitor 13:32:43 INFO - Running setup.py install for mozsystemmonitor 13:32:43 INFO - Successfully installed mozsystemmonitor 13:32:43 INFO - Cleaning up... 13:32:43 INFO - Return code: 0 13:32:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:32:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fb2bfc8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x223d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239a0b0>, '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 0x239afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239b440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1450128745.803361-117896578', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:32:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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/build 13:32:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:32:43 INFO - Using env: {'DISPLAY': ':0', 13:32:43 INFO - 'HOME': '/home/cltbld', 13:32:43 INFO - 'LANG': 'en_US.UTF-8', 13:32:43 INFO - 'LANGUAGE': 'en_US:en', 13:32:43 INFO - 'LOGNAME': 'cltbld', 13:32:43 INFO - 'MAIL': '/var/mail/cltbld', 13:32:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:43 INFO - 'MOZ_NO_REMOTE': '1', 13:32:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:43 INFO - 'NO_EM_RESTART': '1', 13:32:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:43 INFO - 'PWD': '/builds/slave/test', 13:32:43 INFO - 'SHELL': '/bin/bash', 13:32:43 INFO - 'SHLVL': '1', 13:32:43 INFO - 'TERM': 'linux', 13:32:43 INFO - 'TMOUT': '86400', 13:32:43 INFO - 'USER': 'cltbld', 13:32:43 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1450128745.803361-117896578', 13:32:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:43 INFO - '_': '/tools/buildbot/bin/python'} 13:32:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:43 INFO - Downloading/unpacking blobuploader==1.2.4 13:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:45 INFO - Downloading blobuploader-1.2.4.tar.gz 13:32:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 13:32:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:32:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 13:32:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:32:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:45 INFO - Downloading docopt-0.6.1.tar.gz 13:32:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 13:32:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:32:45 INFO - Installing collected packages: blobuploader, requests, docopt 13:32:45 INFO - Running setup.py install for blobuploader 13:32:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:32:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:32:46 INFO - Running setup.py install for requests 13:32:46 INFO - Running setup.py install for docopt 13:32:46 INFO - Successfully installed blobuploader requests docopt 13:32:46 INFO - Cleaning up... 13:32:46 INFO - Return code: 0 13:32:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:32:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/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 0x7fb2bfc8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x223d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239a0b0>, '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 0x239afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239b440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1450128745.803361-117896578', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:32:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/config 13:32:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:32:46 INFO - Using env: {'DISPLAY': ':0', 13:32:46 INFO - 'HOME': '/home/cltbld', 13:32:46 INFO - 'LANG': 'en_US.UTF-8', 13:32:46 INFO - 'LANGUAGE': 'en_US:en', 13:32:46 INFO - 'LOGNAME': 'cltbld', 13:32:46 INFO - 'MAIL': '/var/mail/cltbld', 13:32:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:46 INFO - 'MOZ_NO_REMOTE': '1', 13:32:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:46 INFO - 'NO_EM_RESTART': '1', 13:32:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:46 INFO - 'PWD': '/builds/slave/test', 13:32:46 INFO - 'SHELL': '/bin/bash', 13:32:46 INFO - 'SHLVL': '1', 13:32:46 INFO - 'TERM': 'linux', 13:32:46 INFO - 'TMOUT': '86400', 13:32:46 INFO - 'USER': 'cltbld', 13:32:46 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1450128745.803361-117896578', 13:32:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:46 INFO - '_': '/tools/buildbot/bin/python'} 13:32:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:32:46 INFO - Running setup.py (path:/tmp/pip-Q8qxFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:32:46 INFO - Running setup.py (path:/tmp/pip-JcEwxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:32:46 INFO - Running setup.py (path:/tmp/pip-VXs7IW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:32:46 INFO - Running setup.py (path:/tmp/pip-ADZDor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:32:47 INFO - Running setup.py (path:/tmp/pip-rd0EGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:32:47 INFO - Running setup.py (path:/tmp/pip-HivDPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:32:47 INFO - Running setup.py (path:/tmp/pip-Te_074-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:32:47 INFO - Running setup.py (path:/tmp/pip-CDtvAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:32:47 INFO - Running setup.py (path:/tmp/pip-7z_myO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:32:47 INFO - Running setup.py (path:/tmp/pip-aVwMJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:32:47 INFO - Running setup.py (path:/tmp/pip-8eUY_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:32:47 INFO - Running setup.py (path:/tmp/pip-X7edRw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:32:47 INFO - Running setup.py (path:/tmp/pip-tG3lj8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:32:47 INFO - Running setup.py (path:/tmp/pip-B6hXIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:32:47 INFO - Running setup.py (path:/tmp/pip-PnH3wt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:32:47 INFO - Running setup.py (path:/tmp/pip-oqlNQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:32:47 INFO - Running setup.py (path:/tmp/pip-qSbMyv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:32:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:32:47 INFO - Running setup.py install for manifestparser 13:32:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:32:48 INFO - Running setup.py install for mozcrash 13:32:48 INFO - Running setup.py install for mozdebug 13:32:48 INFO - Running setup.py install for mozdevice 13:32:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:32:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:32:48 INFO - Running setup.py install for mozfile 13:32:48 INFO - Running setup.py install for mozhttpd 13:32:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:32:48 INFO - Running setup.py install for mozinfo 13:32:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:32:48 INFO - Running setup.py install for mozInstall 13:32:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:32:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:32:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:32:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:32:48 INFO - Running setup.py install for mozleak 13:32:48 INFO - Running setup.py install for mozlog 13:32:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:32:48 INFO - Running setup.py install for moznetwork 13:32:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:32:49 INFO - Running setup.py install for mozprocess 13:32:49 INFO - Running setup.py install for mozprofile 13:32:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:32:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:32:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:32:49 INFO - Running setup.py install for mozrunner 13:32:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:32:49 INFO - Running setup.py install for mozscreenshot 13:32:49 INFO - Running setup.py install for moztest 13:32:49 INFO - Running setup.py install for mozversion 13:32:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:32:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:32:49 INFO - Cleaning up... 13:32:49 INFO - Return code: 0 13:32:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:32:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/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 0x7fb2bfc8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x223d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239a0b0>, '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 0x239afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239b440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1450128745.803361-117896578', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:32:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/config 13:32:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:32:49 INFO - Using env: {'DISPLAY': ':0', 13:32:49 INFO - 'HOME': '/home/cltbld', 13:32:49 INFO - 'LANG': 'en_US.UTF-8', 13:32:49 INFO - 'LANGUAGE': 'en_US:en', 13:32:49 INFO - 'LOGNAME': 'cltbld', 13:32:49 INFO - 'MAIL': '/var/mail/cltbld', 13:32:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:49 INFO - 'MOZ_NO_REMOTE': '1', 13:32:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:49 INFO - 'NO_EM_RESTART': '1', 13:32:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:49 INFO - 'PWD': '/builds/slave/test', 13:32:49 INFO - 'SHELL': '/bin/bash', 13:32:49 INFO - 'SHLVL': '1', 13:32:49 INFO - 'TERM': 'linux', 13:32:49 INFO - 'TMOUT': '86400', 13:32:49 INFO - 'USER': 'cltbld', 13:32:49 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1450128745.803361-117896578', 13:32:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:49 INFO - '_': '/tools/buildbot/bin/python'} 13:32:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:32:49 INFO - Running setup.py (path:/tmp/pip-VjrJgr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 13:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:32:50 INFO - Running setup.py (path:/tmp/pip-TAsj71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:32:50 INFO - Running setup.py (path:/tmp/pip-NWl7iG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:32:50 INFO - Running setup.py (path:/tmp/pip-SCDrfn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:32:50 INFO - Running setup.py (path:/tmp/pip-mStRBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 13:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:32:50 INFO - Running setup.py (path:/tmp/pip-2KfOjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 13:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:32:50 INFO - Running setup.py (path:/tmp/pip-zN0BYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 13:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:32:50 INFO - Running setup.py (path:/tmp/pip-8T4Ri8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 13:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:32:50 INFO - Running setup.py (path:/tmp/pip-5IGCHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 13:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:32:50 INFO - Running setup.py (path:/tmp/pip-1I5SpX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:32:50 INFO - Running setup.py (path:/tmp/pip-bOBh1r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:32:50 INFO - Running setup.py (path:/tmp/pip-eAyzjg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:32:50 INFO - Running setup.py (path:/tmp/pip-oD10j4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 13:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:32:50 INFO - Running setup.py (path:/tmp/pip-sO5_nc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:32:50 INFO - Running setup.py (path:/tmp/pip-hS5Kl4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:32:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 13:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:32:51 INFO - Running setup.py (path:/tmp/pip-F2vQ8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:32:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 13:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:32:51 INFO - Running setup.py (path:/tmp/pip-adUrlK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:32:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 13:32:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:32:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:32:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:32:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:32:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:32:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:32:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:52 INFO - Downloading blessings-1.5.1.tar.gz 13:32:52 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 13:32:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:32:52 INFO - Installing collected packages: blessings 13:32:52 INFO - Running setup.py install for blessings 13:32:53 INFO - Successfully installed blessings 13:32:53 INFO - Cleaning up... 13:32:53 INFO - Return code: 0 13:32:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:32:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:32:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:32:53 INFO - Reading from file tmpfile_stdout 13:32:53 INFO - Current package versions: 13:32:53 INFO - argparse == 1.2.1 13:32:53 INFO - blessings == 1.5.1 13:32:53 INFO - blobuploader == 1.2.4 13:32:53 INFO - docopt == 0.6.1 13:32:53 INFO - manifestparser == 1.1 13:32:53 INFO - mozInstall == 1.12 13:32:53 INFO - mozcrash == 0.16 13:32:53 INFO - mozdebug == 0.1 13:32:53 INFO - mozdevice == 0.47 13:32:53 INFO - mozfile == 1.2 13:32:53 INFO - mozhttpd == 0.7 13:32:53 INFO - mozinfo == 0.9 13:32:53 INFO - mozleak == 0.1 13:32:53 INFO - mozlog == 3.1 13:32:53 INFO - moznetwork == 0.27 13:32:53 INFO - mozprocess == 0.22 13:32:53 INFO - mozprofile == 0.27 13:32:53 INFO - mozrunner == 6.11 13:32:53 INFO - mozscreenshot == 0.1 13:32:53 INFO - mozsystemmonitor == 0.0 13:32:53 INFO - moztest == 0.7 13:32:53 INFO - mozversion == 1.4 13:32:53 INFO - psutil == 3.1.1 13:32:53 INFO - requests == 1.2.3 13:32:53 INFO - wsgiref == 0.1.2 13:32:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:32:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/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 0x7fb2bfc8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x223d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239a0b0>, '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 0x239afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239b440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1450128745.803361-117896578', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:32:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/talos 13:32:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:32:53 INFO - Using env: {'DISPLAY': ':0', 13:32:53 INFO - 'HOME': '/home/cltbld', 13:32:53 INFO - 'LANG': 'en_US.UTF-8', 13:32:53 INFO - 'LANGUAGE': 'en_US:en', 13:32:53 INFO - 'LOGNAME': 'cltbld', 13:32:53 INFO - 'MAIL': '/var/mail/cltbld', 13:32:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:53 INFO - 'MOZ_NO_REMOTE': '1', 13:32:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:53 INFO - 'NO_EM_RESTART': '1', 13:32:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:53 INFO - 'PWD': '/builds/slave/test', 13:32:53 INFO - 'SHELL': '/bin/bash', 13:32:53 INFO - 'SHLVL': '1', 13:32:53 INFO - 'TERM': 'linux', 13:32:53 INFO - 'TMOUT': '86400', 13:32:53 INFO - 'USER': 'cltbld', 13:32:53 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1450128745.803361-117896578', 13:32:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:53 INFO - '_': '/tools/buildbot/bin/python'} 13:32:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:32:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:32:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:32:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:32:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:32:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:32:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:32:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:32:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:32:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:32:53 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:32:53 INFO - Cleaning up... 13:32:53 INFO - Return code: 0 13:32:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:32:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fb2bfc8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x223d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239a0b0>, '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 0x239afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239b440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1450128745.803361-117896578', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:32:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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/build 13:32:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:32:53 INFO - Using env: {'DISPLAY': ':0', 13:32:53 INFO - 'HOME': '/home/cltbld', 13:32:53 INFO - 'LANG': 'en_US.UTF-8', 13:32:53 INFO - 'LANGUAGE': 'en_US:en', 13:32:53 INFO - 'LOGNAME': 'cltbld', 13:32:53 INFO - 'MAIL': '/var/mail/cltbld', 13:32:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:53 INFO - 'MOZ_NO_REMOTE': '1', 13:32:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:53 INFO - 'NO_EM_RESTART': '1', 13:32:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:53 INFO - 'PWD': '/builds/slave/test', 13:32:53 INFO - 'SHELL': '/bin/bash', 13:32:53 INFO - 'SHLVL': '1', 13:32:53 INFO - 'TERM': 'linux', 13:32:53 INFO - 'TMOUT': '86400', 13:32:53 INFO - 'USER': 'cltbld', 13:32:53 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1450128745.803361-117896578', 13:32:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:53 INFO - '_': '/tools/buildbot/bin/python'} 13:32:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:53 INFO - Downloading/unpacking jsonschema 13:32:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:32:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 13:32:55 INFO - Downloading/unpacking functools32 (from jsonschema) 13:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:55 INFO - Downloading functools32-3.2.3-2.tar.gz 13:32:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 13:32:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:32:55 INFO - warning: no files found matching '*.txt' 13:32:55 INFO - no previously-included directories found matching 'build' 13:32:55 INFO - no previously-included directories found matching 'dist' 13:32:55 INFO - no previously-included directories found matching '.git*' 13:32:55 INFO - Installing collected packages: jsonschema, functools32 13:32:55 INFO - Running setup.py install for functools32 13:32:55 INFO - warning: no files found matching '*.txt' 13:32:55 INFO - no previously-included directories found matching 'build' 13:32:55 INFO - no previously-included directories found matching 'dist' 13:32:55 INFO - no previously-included directories found matching '.git*' 13:32:55 INFO - Successfully installed jsonschema functools32 13:32:55 INFO - Cleaning up... 13:32:55 INFO - Return code: 0 13:32:55 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:32:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fb2bfc8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x223d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239a0b0>, '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 0x239afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239b440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1450128745.803361-117896578', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:32:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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/build 13:32:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 13:32:55 INFO - Using env: {'DISPLAY': ':0', 13:32:55 INFO - 'HOME': '/home/cltbld', 13:32:55 INFO - 'LANG': 'en_US.UTF-8', 13:32:55 INFO - 'LANGUAGE': 'en_US:en', 13:32:55 INFO - 'LOGNAME': 'cltbld', 13:32:55 INFO - 'MAIL': '/var/mail/cltbld', 13:32:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:55 INFO - 'MOZ_NO_REMOTE': '1', 13:32:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:55 INFO - 'NO_EM_RESTART': '1', 13:32:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:55 INFO - 'PWD': '/builds/slave/test', 13:32:55 INFO - 'SHELL': '/bin/bash', 13:32:55 INFO - 'SHLVL': '1', 13:32:55 INFO - 'TERM': 'linux', 13:32:55 INFO - 'TMOUT': '86400', 13:32:55 INFO - 'USER': 'cltbld', 13:32:55 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1450128745.803361-117896578', 13:32:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:55 INFO - '_': '/tools/buildbot/bin/python'} 13:32:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:56 INFO - Downloading/unpacking flake8 13:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:32:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 13:32:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:32:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 13:32:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 13:32:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:32:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 13:32:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:32:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:32:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:32:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:32:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:32:58 INFO - no previously-included directories found matching 'docs/_build' 13:32:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:32:58 INFO - Running setup.py install for pep8 13:32:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:32:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:32:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:32:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:32:58 INFO - no previously-included directories found matching 'docs/_build' 13:32:58 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:32:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:32:58 INFO - Cleaning up... 13:32:58 INFO - Return code: 0 13:32:58 INFO - Running post-action listener: _resource_record_post_action 13:32:58 INFO - Running post-action listener: _start_resource_monitoring 13:32:58 INFO - Starting resource monitoring. 13:32:58 INFO - ##### 13:32:58 INFO - ##### Running install step. 13:32:58 INFO - ##### 13:32:58 INFO - Running pre-action listener: _resource_record_pre_action 13:32:58 INFO - Running main action method: install 13:32:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:32:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:32:58 INFO - Reading from file tmpfile_stdout 13:32:58 INFO - Detecting whether we're running mozinstall >=1.0... 13:32:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:32:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:32:58 INFO - Reading from file tmpfile_stdout 13:32:58 INFO - Output received: 13:32:58 INFO - Usage: mozinstall [options] installer 13:32:58 INFO - Options: 13:32:58 INFO - -h, --help show this help message and exit 13:32:58 INFO - -d DEST, --destination=DEST 13:32:58 INFO - Directory to install application into. [default: 13:32:58 INFO - "/builds/slave/test"] 13:32:58 INFO - --app=APP Application being installed. [default: firefox] 13:32:58 INFO - mkdir: /builds/slave/test/build/application 13:32:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:32:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:33:13 INFO - Reading from file tmpfile_stdout 13:33:13 INFO - Output received: 13:33:13 INFO - /builds/slave/test/build/application/firefox/firefox 13:33:13 INFO - Running post-action listener: _resource_record_post_action 13:33:13 INFO - ##### 13:33:13 INFO - ##### Running run-tests step. 13:33:13 INFO - ##### 13:33:13 INFO - Running pre-action listener: _resource_record_pre_action 13:33:13 INFO - Running main action method: run_tests 13:33:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:33:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:33:13 INFO - Python 2.7.3 13:33:13 INFO - Return code: 0 13:33:13 INFO - grabbing minidump binary from tooltool 13:33:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:33:13 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/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 0x239a0b0>, '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 0x239afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239b440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:33:13 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 13:33:13 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 13:33:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:33:13 INFO - Return code: 0 13:33:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:33:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:33:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:33:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:33:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:33:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:33:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:33:14 INFO - Return code: 0 13:33:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost'] in /builds/slave/test/build 13:33:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --webServer localhost 13:33:14 INFO - Using env: {'DISPLAY': ':0', 13:33:14 INFO - 'HOME': '/home/cltbld', 13:33:14 INFO - 'LANG': 'en_US.UTF-8', 13:33:14 INFO - 'LANGUAGE': 'en_US:en', 13:33:14 INFO - 'LOGNAME': 'cltbld', 13:33:14 INFO - 'MAIL': '/var/mail/cltbld', 13:33:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:33:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:33:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:14 INFO - 'MOZ_NO_REMOTE': '1', 13:33:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:33:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:33:14 INFO - 'NO_EM_RESTART': '1', 13:33:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:33:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:14 INFO - 'PWD': '/builds/slave/test', 13:33:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:33:14 INFO - 'SHELL': '/bin/bash', 13:33:14 INFO - 'SHLVL': '1', 13:33:14 INFO - 'TERM': 'linux', 13:33:14 INFO - 'TMOUT': '86400', 13:33:14 INFO - 'USER': 'cltbld', 13:33:14 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1450128745.803361-117896578', 13:33:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:14 INFO - '_': '/tools/buildbot/bin/python'} 13:33:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost'] with output_timeout 3600 13:33:14 INFO - mozversion INFO | application_buildid: 20151214121624 13:33:14 INFO - mozversion INFO | application_changeset: 06ab805e14b5e6d8a8a99c7846c8fde163a9e5d7 13:33:14 INFO - mozversion INFO | application_display_name: Nightly 13:33:14 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:33:14 INFO - mozversion INFO | application_name: Firefox 13:33:14 INFO - mozversion INFO | application_remotingname: firefox 13:33:14 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 13:33:14 INFO - mozversion INFO | application_vendor: Mozilla 13:33:14 INFO - mozversion INFO | application_version: 46.0a1 13:33:14 INFO - mozversion INFO | platform_buildid: 20151214121624 13:33:14 INFO - mozversion INFO | platform_changeset: 06ab805e14b5e6d8a8a99c7846c8fde163a9e5d7 13:33:14 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 13:33:14 INFO - mozversion INFO | platform_version: 46.0a1 13:33:14 INFO - 2015-12-14 13:33:14,696 DEBUG : using testdate: 1450128794 13:33:14 INFO - 2015-12-14 13:33:14,696 DEBUG : actual date: 1450128794 13:33:14 INFO - 2015-12-14 13:33:14,704 INFO : starting webserver on 'localhost:36894' 13:33:14 INFO - 2015-12-14 13:33:14,705 INFO : Starting test suite talos-linux64-ix-004.e 13:33:14 INFO - 2015-12-14 13:33:14,705 INFO : Starting test dromaeo_css 13:33:14 INFO - 2015-12-14 13:33:14,706 DEBUG : operating with platform_type : linux_ 13:33:14 INFO - 2015-12-14 13:33:14,706 INFO : Initialising browser for dromaeo_css test... 13:33:14 INFO - 2015-12-14 13:33:14,723 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqjLSes/profile http://localhost:36894/getInfo.html 13:33:19 INFO - 2015-12-14 13:33:19,512 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:33:19 INFO - 2015-12-14 13:33:19,512 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:33:19 INFO - 2015-12-14 13:33:19,512 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:33:19 INFO - 2015-12-14 13:33:19,512 DEBUG : BROWSER_OUTPUT: __metrics 13:33:19 INFO - 2015-12-14 13:33:19,641 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 13:33:20 INFO - 2015-12-14 13:33:20,595 INFO : Browser initialized. 13:33:20 INFO - 2015-12-14 13:33:20,595 INFO : Running cycle 1/1 for dromaeo_css test... 13:33:20 INFO - 2015-12-14 13:33:20,596 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqjLSes/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:33:32 INFO - 2015-12-14 13:33:32,693 DEBUG : BROWSER_OUTPUT: RSS: Main: 143523840 13:33:32 INFO - 2015-12-14 13:33:32,694 DEBUG : BROWSER_OUTPUT: 13:34:22 INFO - 2015-12-14 13:34:22,328 DEBUG : BROWSER_OUTPUT: 1450128862326 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 13:36:34 INFO - 2015-12-14 13:36:34,476 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36894/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36894/tests/dromaeo/cssquery-ext.html) 13:36:35 INFO - 2015-12-14 13:36:35,513 DEBUG : BROWSER_OUTPUT: RSS: Main: 148336640 13:36:35 INFO - 2015-12-14 13:36:35,513 DEBUG : BROWSER_OUTPUT: 13:39:37 INFO - 2015-12-14 13:39:37,617 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36894/tests/dromaeo/cssquery-ext.html (next: http://localhost:36894/tests/dromaeo/cssquery-jquery.html) 13:39:38 INFO - 2015-12-14 13:39:38,210 DEBUG : BROWSER_OUTPUT: RSS: Main: 145260544 13:39:38 INFO - 2015-12-14 13:39:38,210 DEBUG : BROWSER_OUTPUT: 13:42:40 INFO - 2015-12-14 13:42:40,020 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36894/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36894/tests/dromaeo/cssquery-mootools.html) 13:42:40 INFO - 2015-12-14 13:42:40,616 DEBUG : BROWSER_OUTPUT: RSS: Main: 146079744 13:42:40 INFO - 2015-12-14 13:42:40,616 DEBUG : BROWSER_OUTPUT: 13:45:42 INFO - 2015-12-14 13:45:42,391 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36894/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36894/tests/dromaeo/cssquery-prototype.html) 13:45:43 INFO - 2015-12-14 13:45:43,005 DEBUG : BROWSER_OUTPUT: RSS: Main: 143597568 13:45:43 INFO - 2015-12-14 13:45:43,005 DEBUG : BROWSER_OUTPUT: 13:48:45 INFO - 2015-12-14 13:48:45,611 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36894/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36894/tests/dromaeo/cssquery-yui.html) 13:48:46 INFO - 2015-12-14 13:48:46,254 DEBUG : BROWSER_OUTPUT: RSS: Main: 143613952 13:48:46 INFO - 2015-12-14 13:48:46,255 DEBUG : BROWSER_OUTPUT: 13:51:48 INFO - 2015-12-14 13:51:48,720 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36894/tests/dromaeo/cssquery-yui.html (next: http://localhost:36894/tests/dromaeo/cssquery-dojo.html) 13:51:48 INFO - 2015-12-14 13:51:48,971 DEBUG : BROWSER_OUTPUT: RSS: Main: 146112512 13:51:48 INFO - 2015-12-14 13:51:48,971 DEBUG : BROWSER_OUTPUT: 13:51:48 INFO - 2015-12-14 13:51:48,972 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:51:48 INFO - 2015-12-14 13:51:48,972 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:51:48 INFO - 2015-12-14 13:51:48,972 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:51:48 INFO - 2015-12-14 13:51:48,972 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:51:48 INFO - 2015-12-14 13:51:48,972 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2679.4239238563705;2721.945561088777;2761.2406588188246;2781.694013658497;2782.4296019316057;4647.070585882829;4848.369711937447;4851.878703032426;4854.5388188122115;4880.170371036923;4705.882352941178;4749.762511874401;4752.500987396317;4808.759562021903;4815.686980346275;4389.495208051083;4463.285874260119;4549.408576885;4552.544745525437;4607.723536587799;4256.659467242629;4515.345274935133;4551.499335073139;4563.110193512266;4652.046330502239;4313.245182093121;4350.15172041452;4377.824887004516;4399.978000110011;4442.311441726538;4482.8655140345845;4500.684952053325;4503.256962601167;4504.369388285642;4552.817887284505;4295.828166873322;4385.627221686161;4445.644348452116;4457.7651231330365;4487.865364039084;4595.919958809677;4660.836870709509;4670.626349892001;4710.3641008463765;4738.028704115648;5146.3824341078935;5180.041692286939;5185.351831021122;5186.5850731941355;5187.04039752647;4956.950430495685;5048.242763585455;5056.62075344347;5208.635395522315;5280.471952804727;4805.255185446262;4820.68665536739;4822.469528351879;4869.099216644897;4874.439439464436;5324.547413469821;5327.200919862052;5328.733563321818;5329.040772660881;5334;4858.6356023297685;4954.504549545089;5023.773930173151;5113.079645663742;5121.615878809104;5184.559312458483;5206.817761378409;5209.921851172236;5216.295800066942;5234.842954711288;5158.97420512895;5165.070287348238;5173.1722924331925;5184.481551844785;5200.193969934666;4799.448063472675;4895.6083513318845;5041.8487445376695;5108.182690769459;5135.409427915837;4280.957190428056;4333.046729719456;4339.067100573392;4346.282863327516;4375.343698445195;3584.0143960411096;3808.447775072599;3809.3333666608232;3834.501514803058;3857.8263978121054;4423.911521769546;4475.373447717322;4483;4541.886452838706;4569.817207311737;5182.067227899014;5223.373195216523;5227.477252274818;5240.528352448222;5241.947580524222;4323.762193079411;4417.580329868657;4502.3246513023305;4520.254158063948;4577.1074640444795;4532.388127602731;4607.516210797885;4618.607418369476;4634.351190833286;4674.626029917598;4878.536539028786;4913.336699545515;4933.407991041098;4945.5301746333325;4960.0327936052845;4908.165611845923;5024.698518088926;5107.361579802525;5252.2646829444675;5291.867703307448;4861.222204447272;4888.319022934898;4932.235503496964;4935.580475659609;4947.82682606107;5088.262201980618;5103.055934652101;5119.5648369887485;5131.846044618667;5133.922991155061;5031.119554078095;5125.615578831528;5138.794448222029;5197.324347834758;5237.135872581134;4981.501849814989;5041.991601679752;5070.518300761421;5077.644564880571;5122.436531981553;5037.798488060583;5050.823221187241;5068.619853511075;5080.237964305236;5087.720175390241;4676.228422310281;4754.025424787841;4825;4923.163062279349;4940.333055037524;5054.368203974504;5118.718470484159;5130.204818253177;5140;5144.6655967362;4702.388689470347;4996.725180115129;5001.274815151855;5006.974965125151;5028.220625803006 13:51:48 INFO - 2015-12-14 13:51:48,973 DEBUG : BROWSER_OUTPUT: |1;ext.html;557.0057447456294;559.0551967175473;564.4553006348873;568.272611057846;571.1432850723914;35454;36088.278234435325;36111.81944090276;36157.819210903945;36236.45645315316;39548.406773898416;39711.80144099276;40115.598844011554;40168.39747403784;40252;7870.606469676508;8052.5973701315;8084.989376327959;8090.757277281661;8095.433319667625;7872.212778722139;7958.045034595857;7977.920220797805;7978.880316795224;7979.800504987393;7909.327707144871;7973.083095444011;7979.162187970267;7990.800229994267;7993.680252789882;7908.802279943019;7957.522548647042;7960.24377684122;8001.719939802079;8006.719764808204;7791.571463569501;7862.174471680506;7883.054033515958;7898.447108702393;7906.248906353945;36835;37338.81330593357;37529.249415011545;37557.24885502302;37586.24827503462;2386.7971222446113;2888.768898488116;2969.747571456429;3071;3129.0769223079246;26570;30082.09753707392;30947.535786963213;31499;32271;3380.678835510623;3392.5928888533285;3421.6920477156928;3467.5665541807275;3475.565554305712;172636;173990.1300493502;174570;175108;175206;45367.546324536335;46484.97847639892;48890.26664600034;49430.75284623554;53427;47139.76430117896;47248.291275630894;47273.290900636515;47316.29025564619;47342.526574734504;12063.215890967234;12081.154319197747;12123.515059397525;12202.572909948109;12253.632391028283;9245.306602004877;9294.209992150743;9310.86033709495;9310.906890931139;9345.813083738287;17661.470155895342;17902.5524361892;17953.102344882704;17983.280668773103;18071;7568.129665088585;7799.493032952953;7861.646225919847;7905.446618736633;7963.681452741941;870.7257213977576;908.981820363589;918.8575770755543;958.7890664053897;985.8028394321165;27240.72759272382;27331.86334068357;27403.45193096127;28919.252670996222;31151.221219469695;947.8767760191131;977.2084611464736;1028.6194108179873;1037.6368271105205;1085.9619913302997;12990.220586764824;13192.274424906722;13271.73456530864;13280.73438531224;13352;316944;321065;321196.54615542357;323203;323929;44988.77505612451;45211.773941130086;45278.32082518765;45484.545154548694;45520.77239613781;1121.198343184627;1221.1268942706008;1240.8200810882372;1242.2608547913976;1344.9663758405923;26904.865475672497;27329.180124596292;27691.307717306423;27694.861525692242;27765.305867353476;37356.62643373531;37573.62426375701;37616.62383376241;37636.435453467675;37847.43228851625;180305;180530;182711;183008;185834;28590.426861582557;29252.268693282836;29390.706092938795;29425;29479.557806633347;37406.251874962894;37565.81217093897;38063.80968095142;38359.61640383561;38534;32123.839380802947;32164.839175803972;32750.50874236936;32891.17772055718;32937.34125317432;32989;33078;33323.50014749829;33414.498782517796;33523.83238083892;32176.35647287088;32393.352132956737;32417.51373729443;38087.42868856914;38992;28412.857935710188;29642;30489.847550762104;34514.654853451146;35508;23819.52360952806;23854.284371468882;23860.403489912893;23885.761142388354;24096 13:51:48 INFO - 2015-12-14 13:51:48,974 DEBUG : BROWSER_OUTPUT: |2;jquery.html;331.29599600848206;331.40181971541364;332.70721764846945;335.3276680256086;337.25466718551996;15286.84713152868;15548.378064877406;15809.367625294974;16681.83318166818;17193.656126877457;9982.950085249564;10208.591656333756;13691.863081369183;14859.182744949023;14903.10581365119;4458.531854155308;4525.886852828673;4638.55933686301;5190.195519694435;5214.4524824893215;5114.053900028488;5136.152534831767;5149.974250128744;5156.123459011958;5156.149235376159;5078.49215078491;5108.540231379176;6084.391560843925;6217.906731399033;6219.880421524123;6138.17134686816;6160.383961603826;6188.47397971173;6212.223472065992;6389.424951754364;6079.665618390986;6101.633901965896;6122.47958923492;6131.14164017038;6135.938640613626;21373.46566335854;21661.783382166293;21718.348449546538;22552;22580.322590322317;1806.9367572134913;1862.9068546572616;1917.5809900673542;1951.7267582538313;1967.2032826705208;14182.787258191032;14205.715885682332;14222.288885555681;14390.928045359811;14483.832024663508;1874.8406385457251;1922.0774028466415;1931.5750534882304;1935.4290484307164;1950.1906708715867;60790;65173.674131629516;65451.345486545004;65512.67243663751;65855.3414465854;15936.442224522087;15986.280617372246;16041.197940102948;16092.919535402249;16293.34826606946;23519.294421167393;23544.64683029756;23630.29109126729;23768;23769.524609507713;7833.099193592696;7916.762497125095;7961.761147165478;7985.72049978248;8115.310198633064;6326.145970294044;6396.872062558816;6453.193350831146;6477.740890364333;6524.739010439529;7881.014873140857;7899.565523896241;7914.129445760962;7989.201079891965;8016.7194148204535;1738.4610770661136;1814.7005744052346;3021.773366997484;3172.730317922956;3279.4588892832894;802.6468353924255;835.1398059998212;929.8884133903839;972.1202311907734;992.831218692824;14881.404743810343;14938.925305373403;15852.52442426729;16311;16433.178341082898;831.7754206364368;843.6836186430089;915.1031988651159;922.5341202692597;970.96601618943;9136.451812891248;9293.535323233811;9299.395539289924;9367.344285899922;9396.953015235016;440164;440831;446277;448626;449607;66671.66664166746;69596.6520167396;70360;71472.64263678648;71660.28339716536;1056.392574269798;1066.7546464313252;1068.460427484131;1073.0557109743531;1078.8867168947147;14031.228282444155;14198.858011420167;14266.643333916734;14447.422103115758;15061;32018.839905800323;32034.03897883067;32273.51589726203;32735.83632081824;33328.50007249942;43383.34924976065;43701;43799.781001094794;44083.55916440795;45792.77103614461;8693.521856297964;8949.642014319354;9006.954965225394;9101.40840845343;9138.680146195116;10559.419231942316;12323.938380308042;15949.362025518849;16710.66578668444;16760.245788939283;13399.062065655311;13407;13833.170009799444;14058.78911816344;14119.788203177166;13175.736485270432;13461.932690336485;13693.726125477633;13769.31153442344;13787;13856.515021974183;13988.860111399163;14130.50543230982;14388.640283992565;14450.494232701805;8922.286217102486;9031.36780425364;9059.365844391094;9074.637014519345;9132.452052876582;9492.24393487207;9667.9033209667;9751.609935602497;14257.572272831416;14309.785353219502 13:51:48 INFO - 2015-12-14 13:51:48,978 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1455.8325792533863;1681.6720739455807;1715.8970461772294;1720.2602880761267;1752.0538908989142;6029.186059881915;6216.378362163793;7169.390601798847;7355.668994895236;7358.448116391265;6763.323667633234;6926.099607051089;6971;6983.7555685551015;7003;2037.103674383274;2091.048572899327;2092.016752126498;2092.1108528875243;2092.6337890869113;2099.4751312171957;2107.083418712865;2113.3765539165906;2150.6773983902463;2151.7848215178437;2127.0747224957117;2145.570885822842;2146.710194123789;2165.8808765517892;2173.3588591365506;2100.1284466946277;2118.947026324339;2125.4048866317457;2126.393977716343;2127.755308139568;2051.8461115416253;2057.825084867773;2057.86623869448;2057.989710051455;2062.2163577840324;7230.132384113887;7260.96369518149;7278.9272107278775;7286.052813134312;7322.121345438582;4066.34938409853;4115.814788334532;4123.927778777509;4135.048938744106;4146.212219678251;2617.175589689242;2636.7890568754647;2724.5913113033007;2727.6454060971946;2732.562789953598;819.2053707903324;834.0658462521953;839.8068444257793;849.3544905871582;856.208007592974;9602.231821454267;9621.230301575857;9649.758756031155;9697.466639334903;9711.27165462593;3860.517435320585;3863.188730366598;3917.6474117329576;3944.684425245973;3963.4649322341115;8341.290990265774;8388.37087218461;8398.748037558884;8400.495970241805;8403.159684031549;4310.741355518679;4318.3090705486975;4330.437043184429;4350.456192975878;4360.869173924787;3322.9335413291597;3404.38721030212;3917.138229589486;3925.450436938831;3929.8821035368983;3395.168183794986;3414.3171365726953;3433.8626454941523;3438.948415773765;3443.328550932544;1084.7938891610568;1102.8456016157745;1109.2678831970861;1110.5779803674714;1111.0944580167138;1007.37039350406;1008.3496144986443;1012.6556970629874;1015.1979935850743;1057.7672911959357;6748.291429399842;6765.661716914135;6766.560173588701;6770.763023294161;6789.72841086351;432.34499732904675;439.18969501270107;442.7498463368187;443.51656694203473;445.1120015568961;5285.947140528546;5319.308489896289;5333.626646134733;5339.038972984822;5344.91982620261;8304.584770761438;8688.78278043054;8777.51723655205;8788.516631585324;8826.338024648048;8507.149285071568;8564;8607.870881936777;8644.827103458021;8674.86987695185;6735.124433823572;6750.763723269662;6852.725890964306;6873.347032031849;6877.2091209510545;6440.549161558646;6442.742290308335;6451.806445806634;6466.030095485715;6483.870322593428;7507.249275072449;7760.6418876695225;7768.378529717722;7777.1833957433655;7811.726589569338;7672.6547305372505;7980.521168729895;7992.720254791055;8004.959975200087;8042.437029407885;5333.493318134771;5642.069058605284;6126.1423400724825;6359.523035772429;6419.35806419373;6564.80305590833;6802.319768023158;6826.078479405415;6840.213375461686;6845.726170953106;6297.874042519033;6363.936360636334;6449.097126402401;6562.212534495891;6590.901136483052;6293.811185664437;6485.902711459237;6488.772892948724;6555.508336874658;6591.406773390418;6352.68236588178;6372.904406433814;6383.489320854228;6390.488760899024;6398.264199617103;5918.852028699317;5928.67392293428;5961;5977.940220597912;5996.70016499182;6148.108524263867;6170.845728856814;6212.099245609271;6222.533310001678;6247.0629405589525 13:51:48 INFO - 2015-12-14 13:51:48,978 DEBUG : BROWSER_OUTPUT: |4;prototype.html;304.0498442367601;311.14590449216905;315.0391306515129;318.7545589895779;320.67451536690277;5578.386377498472;5735.684537350444;5745.195672605833;5748.396418376073;5767.884642307162;5595.104783234683;5606.074997625397;5628.26832511774;5634.04221282382;5636.577256705753;4183.832646694129;4298.634616057639;4356.1069980653965;4370.7106403611015;4373.518912919576;4315.309550471925;4336.522982471925;4349.043210493702;4359.106383191438;4359.782010899458;4295.441592592959;4296.8281268749215;4298.613124818766;4301.483821941356;4306.97846510767;4297.957020429787;4298.054428025829;4301.698881078326;4304.182205380967;4310.030243195271;3599.9560127562977;3739.513863197767;3747.1006958330076;3752.249550089966;3753.455748916419;5319.5744340452675;5344.625876188668;5437.510624043855;5444.50999410055;5453.072977593779;4962.106820772259;4970.975145124287;4977.129002424561;4979.10376132296;4986.276989836453;5970.194023806774;6006.489448396847;6013.849653758647;6014.067819487943;6028.879422411527;3993.221321842242;4082.448869402622;4083.9183216335805;4097.8565750198895;4098.774567398792;6187.288461826903;6300.621962682254;6304.432601065881;6306.243250809932;6320.905186422207;4187.309093999456;4193.35003074524;4198.769067701306;4200.243956087872;4201.810918508674;4235.661147108224;4242.342436922282;4259.616634502848;4268.509121451073;4271.444712187458;4800;4872.658913875995;4926.679765815211;4927.704337739747;4932.21084626458;5946.405359464019;5952.940470595326;5964.522838172936;5967.045272756425;5975.342712301644;1482.5181815909873;1500.647347873249;1506.8267149277754;1516.196415899575;1520.1107352198867;1004.8442491413842;1007.7883644434604;1018.8624535687735;1021.7854250607307;1031.0874875734878;5228.189630607262;5244.5279924806955;5257.185136303879;5273.841784746463;5276.261323414725;6225.128482012522;6227.564070515021;6228.190335256388;6228.22147231596;6240.157578726905;5236.423993360727;5238.60710446718;5241.135212689864;5243.501867322599;5246.895062098813;3286.0963235110057;3349.1794510344635;3369.25876307212;3369.7641165118207;3371.494275858641;5681.659100453986;5790.276215473066;5826.951148793173;5827.825165245049;5885.146653735184;6410.61536307823;6440.323766004502;6447.774327898501;6472.320406357265;6478.319776423502;5871.089981052944;5883.735231914659;5885.529157667376;5886.646801191942;5886.676232807151;6163.845903852261;6279.466245369194;6280.434760871543;6288.182536270256;6293.622382657055;6104.755809767559;6110.7555697771595;6120.234970628671;6121.387861213843;6133.4786543142545;5841.853953651193;5846;5882.058870580687;5886.381929897299;5892.823215303548;4152.584741525823;4203.789810509524;4206.8737937861915;4236.978815105905;4252.978735106429;6064.605800622945;6265.624062556261;6282.371762823681;6290.465310448663;6290.99344104941;6032.969835150796;6036.396360363929;6041.2750469943885;6042.607230530001;6044.9395506044375;6014.609050411709;6039.063945088518;6041.063635136561;6042.818715438544;6044.697765111639;5696.1455781633085;5892.94107058924;5896.3514013457625;5900.675462849585;5901.878643057806;6044.9395506044375;6046.032634778414;6049.969750151221;6065.181200538047;6082.239720034996;5932.703364831655;5939;5943.940560594512;5944.881102377842;5952.226210592596 13:51:48 INFO - 2015-12-14 13:51:48,980 DEBUG : BROWSER_OUTPUT: |5;yui.html;716.4733920568378;775.3874439193038;777.8094366880114;790.9327707144893;800.8238187598728;12113.878861211386;12244.632661020183;12279.877201227984;12283.754324913496;12285;10964.616238431656;11555.133364997617;11795.351255680935;11799.646010619696;13013.349332533382;806.701520437439;820.2945466898462;821.4660470694037;821.8438496685641;823.5799742131526;809.6599428240124;814.1126172472004;815.8653822119343;815.8857759913587;816.4162623724036;842.0695131879277;844.543946269014;845.5814371885895;846.174979395091;848.1094850407079;835.0563862834957;837.0541288344193;839.7270886961762;840.9537475438848;841.869510225916;616.9845753856144;620.7641096383345;621.316551793024;624.3506752976898;625.327772644409;10244.436555989418;10339.431331276777;10339.844902326471;10360.171186305153;10376.221783366278;11386;11402.429878506042;11506.827397589042;11571.479283432265;11585.536578536932;9191.126842949909;9240.907590924138;9318.86021709675;9320.161185493338;9321.580528876217;3197.392495425885;3263.3147039121814;3270.967290327114;3286.211309285778;3340.048086295394;37508.249835003146;38579.421308680394;38721.806390968144;38730.6126938727;38964.22071558581;9044.592993315317;9156.26749860023;9273.119053690023;9319.534023298807;9502;15632.4528641497;15717.135557544216;15774.290156942965;15788.447404340794;15789.763153552705;6014.909776353271;6253.843653908598;6538.574992625464;6657.700403481758;6662.933370666328;3456.75802693809;3623.2753449310244;3653.159773252167;3705.1107734144152;3709.9443508347395;2727;2728.6998430172666;2757.696653368128;2758.1863350311705;2760.682521510012;482.156226603444;488.53833127694696;488.6091127098307;492.820120655958;512.180511182113;464.8675127588621;608.9878202435926;622.163190508774;629.9370062993664;634.1217413881807;7613.961930190424;7644.847103057908;7652.885206721904;7754.9224507755325;7769.6115194240065;569.0922977850322;574.0642752313702;594.9167116603679;603.2971588099903;627.576385939489;3609.6931760800626;3712.201876596545;3729.9254014920093;3801.885943421702;3807.143392736612;47772.28341574879;48373.75813120982;48412.27381589279;48590;48620.27069593959;42536.361954570704;42579.57420425756;43836.561634383244;44065;44456;39943.40084898729;41226.38160427596;43495.34756978648;43762.12475750467;43913.34129988053;8185.508869467851;8202.630881610223;8325.875111873205;8397.874031889405;8506.404551681322;31943.840280799377;32077.35845283128;32089.518657219694;32131.518027229144;32505.67494325121;37010.25979480449;38635.806820965714;38833.611663883;39123.608763911994;39304.60695393124;10211.795764084825;10321.174306055347;10388.584456621953;10619.787604248026;10837.349759014485;10460.63387781424;10667.946660266649;11333.943330283295;11351.659450216506;12200.877991219973;10671.89328106709;10760.192985526273;10790.298630588986;10836.512356943798;11223.66329010131;10105.848412273968;10611.257211995086;10697.839532406864;10745.785084298426;11045.28205666629;10588.682339529827;10626.893731062899;10639.946800265949;10687.946560267459;10891.509882055168;8889.955550222467;9279.72160835176;9469.905300947177;9508.429494230368;9618;8532.146785321418;8821.117888211127;8867.556622168737;8939.508327041814;8947.619805763487 13:51:48 INFO - 2015-12-14 13:51:48,980 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:51:48 INFO - 2015-12-14 13:51:48,980 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:51:48 INFO - 2015-12-14 13:51:48,980 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,328 13:51:48 INFO - 2015-12-14 13:51:48,980 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:51:48 INFO - 2015-12-14 13:51:48,980 DEBUG : BROWSER_OUTPUT: __startTimestamp1450129908969__endTimestamp 13:51:48 INFO - 2015-12-14 13:51:48,980 DEBUG : BROWSER_OUTPUT: 13:51:48 INFO - 2015-12-14 13:51:48,980 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:51:48 INFO - 2015-12-14 13:51:48,980 DEBUG : BROWSER_OUTPUT: Number of tests: 6 13:51:48 INFO - 2015-12-14 13:51:48,980 DEBUG : BROWSER_OUTPUT: 13:51:48 INFO - 2015-12-14 13:51:48,980 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4767.35 Median:4880.17 stddev:498.33 (10.2%) stddev-sans-first:472.18 13:51:48 INFO - 2015-12-14 13:51:48,982 DEBUG : BROWSER_OUTPUT: Values: 2679.4 2721.9 2761.2 2781.7 2782.4 4647.1 4848.4 4851.9 4854.5 4880.2 4705.9 4749.8 4752.5 4808.8 4815.7 4389.5 4463.3 4549.4 4552.5 4607.7 4256.7 4515.3 4551.5 4563.1 4652.0 4313.2 4350.2 4377.8 4400.0 4442.3 4482.9 4500.7 4503.3 4504.4 4552.8 4295.8 4385.6 4445.6 4457.8 4487.9 4595.9 4660.8 4670.6 4710.4 4738.0 5146.4 5180.0 5185.4 5186.6 5187.0 4957.0 5048.2 5056.6 5208.6 5280.5 4805.3 4820.7 4822.5 4869.1 4874.4 5324.5 5327.2 5328.7 5329.0 5334.0 4858.6 4954.5 5023.8 5113.1 5121.6 5184.6 5206.8 5209.9 5216.3 5234.8 5159.0 5165.1 5173.2 5184.5 5200.2 4799.4 4895.6 5041.8 5108.2 5135.4 4281.0 4333.0 4339.1 4346.3 4375.3 3584.0 3808.4 3809.3 3834.5 3857.8 4423.9 4475.4 4483.0 4541.9 4569.8 5182.1 5223.4 5227.5 5240.5 5241.9 4323.8 4417.6 4502.3 4520.3 4577.1 4532.4 4607.5 4618.6 4634.4 4674.6 4878.5 4913.3 4933.4 4945.5 4960.0 4908.2 5024.7 5107.4 5252.3 5291.9 4861.2 4888.3 4932.2 4935.6 4947.8 5088.3 5103.1 5119.6 5131.8 5133.9 5031.1 5125.6 5138.8 5197.3 5237.1 4981.5 5042.0 5070.5 5077.6 5122.4 5037.8 5050.8 5068.6 5080.2 5087.7 4676.2 4754.0 4825.0 4923.2 4940.3 5054.4 5118.7 5130.2 5140.0 5144.7 4702.4 4996.7 5001.3 5007.0 5028.2 13:51:48 INFO - 2015-12-14 13:51:48,982 DEBUG : BROWSER_OUTPUT: 13:51:48 INFO - 2015-12-14 13:51:48,982 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:38615.80 Median:35481.00 stddev:61743.73 (174.0%) stddev-sans-first:61850.81 13:51:48 INFO - 2015-12-14 13:51:48,982 DEBUG : BROWSER_OUTPUT: Values: 557.0 559.1 564.5 568.3 571.1 35454.0 36088.3 36111.8 36157.8 36236.5 39548.4 39711.8 40115.6 40168.4 40252.0 7870.6 8052.6 8085.0 8090.8 8095.4 7872.2 7958.0 7977.9 7978.9 7979.8 7909.3 7973.1 7979.2 7990.8 7993.7 7908.8 7957.5 7960.2 8001.7 8006.7 7791.6 7862.2 7883.1 7898.4 7906.2 36835.0 37338.8 37529.2 37557.2 37586.2 2386.8 2888.8 2969.7 3071.0 3129.1 26570.0 30082.1 30947.5 31499.0 32271.0 3380.7 3392.6 3421.7 3467.6 3475.6 172636.0 173990.1 174570.0 175108.0 175206.0 45367.5 46485.0 48890.3 49430.8 53427.0 47139.8 47248.3 47273.3 47316.3 47342.5 12063.2 12081.2 12123.5 12202.6 12253.6 9245.3 9294.2 9310.9 9310.9 9345.8 17661.5 17902.6 17953.1 17983.3 18071.0 7568.1 7799.5 7861.6 7905.4 7963.7 870.7 909.0 918.9 958.8 985.8 27240.7 27331.9 27403.5 28919.3 31151.2 947.9 977.2 1028.6 1037.6 1086.0 12990.2 13192.3 13271.7 13280.7 13352.0 316944.0 321065.0 321196.5 323203.0 323929.0 44988.8 45211.8 45278.3 45484.5 45520.8 1121.2 1221.1 1240.8 1242.3 1345.0 26904.9 27329.2 27691.3 27694.9 27765.3 37356.6 37573.6 37616.6 37636.4 37847.4 180305.0 180530.0 182711.0 183008.0 185834.0 28590.4 29252.3 29390.7 29425.0 29479.6 37406.3 37565.8 38063.8 38359.6 38534.0 32123.8 32164.8 32750.5 32891.2 32937.3 32989.0 33078.0 33323.5 33414.5 33523.8 32176.4 32393.4 32417.5 38087.4 38992.0 28412.9 29642.0 30489.8 34514.7 35508.0 23819.5 23854.3 23860.4 23885.8 24096.0 13:51:48 INFO - 2015-12-14 13:51:48,982 DEBUG : BROWSER_OUTPUT: 13:51:48 INFO - 2015-12-14 13:51:48,982 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26275.70 Median:21860.30 stddev:72707.94 (332.6%) stddev-sans-first:72885.81 13:51:48 INFO - 2015-12-14 13:51:48,982 DEBUG : BROWSER_OUTPUT: Values: 331.3 331.4 332.7 335.3 337.3 15286.8 15548.4 15809.4 16681.8 17193.7 9983.0 10208.6 13691.9 14859.2 14903.1 4458.5 4525.9 4638.6 5190.2 5214.5 5114.1 5136.2 5150.0 5156.1 5156.1 5078.5 5108.5 6084.4 6217.9 6219.9 6138.2 6160.4 6188.5 6212.2 6389.4 6079.7 6101.6 6122.5 6131.1 6135.9 21373.5 21661.8 21718.3 22552.0 22580.3 1806.9 1862.9 1917.6 1951.7 1967.2 14182.8 14205.7 14222.3 14390.9 14483.8 1874.8 1922.1 1931.6 1935.4 1950.2 60790.0 65173.7 65451.3 65512.7 65855.3 15936.4 15986.3 16041.2 16092.9 16293.3 23519.3 23544.6 23630.3 23768.0 23769.5 7833.1 7916.8 7961.8 7985.7 8115.3 6326.1 6396.9 6453.2 6477.7 6524.7 7881.0 7899.6 7914.1 7989.2 8016.7 1738.5 1814.7 3021.8 3172.7 3279.5 802.6 835.1 929.9 972.1 992.8 14881.4 14938.9 15852.5 16311.0 16433.2 831.8 843.7 915.1 922.5 971.0 9136.5 9293.5 9299.4 9367.3 9397.0 440164.0 440831.0 446277.0 448626.0 449607.0 66671.7 69596.7 70360.0 71472.6 71660.3 1056.4 1066.8 1068.5 1073.1 1078.9 14031.2 14198.9 14266.6 14447.4 15061.0 32018.8 32034.0 32273.5 32735.8 33328.5 43383.3 43701.0 43799.8 44083.6 45792.8 8693.5 8949.6 9007.0 9101.4 9138.7 10559.4 12323.9 15949.4 16710.7 16760.2 13399.1 13407.0 13833.2 14058.8 14119.8 13175.7 13461.9 13693.7 13769.3 13787.0 13856.5 13988.9 14130.5 14388.6 14450.5 8922.3 9031.4 9059.4 9074.6 9132.5 9492.2 9667.9 9751.6 14257.6 14309.8 13:51:48 INFO - 2015-12-14 13:51:48,982 DEBUG : BROWSER_OUTPUT: 13:51:48 INFO - 2015-12-14 13:51:48,982 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4982.90 Median:6191.47 stddev:2610.70 (42.2%) stddev-sans-first:2604.56 13:51:48 INFO - 2015-12-14 13:51:48,983 DEBUG : BROWSER_OUTPUT: Values: 1455.8 1681.7 1715.9 1720.3 1752.1 6029.2 6216.4 7169.4 7355.7 7358.4 6763.3 6926.1 6971.0 6983.8 7003.0 2037.1 2091.0 2092.0 2092.1 2092.6 2099.5 2107.1 2113.4 2150.7 2151.8 2127.1 2145.6 2146.7 2165.9 2173.4 2100.1 2118.9 2125.4 2126.4 2127.8 2051.8 2057.8 2057.9 2058.0 2062.2 7230.1 7261.0 7278.9 7286.1 7322.1 4066.3 4115.8 4123.9 4135.0 4146.2 2617.2 2636.8 2724.6 2727.6 2732.6 819.2 834.1 839.8 849.4 856.2 9602.2 9621.2 9649.8 9697.5 9711.3 3860.5 3863.2 3917.6 3944.7 3963.5 8341.3 8388.4 8398.7 8400.5 8403.2 4310.7 4318.3 4330.4 4350.5 4360.9 3322.9 3404.4 3917.1 3925.5 3929.9 3395.2 3414.3 3433.9 3438.9 3443.3 1084.8 1102.8 1109.3 1110.6 1111.1 1007.4 1008.3 1012.7 1015.2 1057.8 6748.3 6765.7 6766.6 6770.8 6789.7 432.3 439.2 442.7 443.5 445.1 5285.9 5319.3 5333.6 5339.0 5344.9 8304.6 8688.8 8777.5 8788.5 8826.3 8507.1 8564.0 8607.9 8644.8 8674.9 6735.1 6750.8 6852.7 6873.3 6877.2 6440.5 6442.7 6451.8 6466.0 6483.9 7507.2 7760.6 7768.4 7777.2 7811.7 7672.7 7980.5 7992.7 8005.0 8042.4 5333.5 5642.1 6126.1 6359.5 6419.4 6564.8 6802.3 6826.1 6840.2 6845.7 6297.9 6363.9 6449.1 6562.2 6590.9 6293.8 6485.9 6488.8 6555.5 6591.4 6352.7 6372.9 6383.5 6390.5 6398.3 5918.9 5928.7 5961.0 5977.9 5996.7 6148.1 6170.8 6212.1 6222.5 6247.1 13:51:48 INFO - 2015-12-14 13:51:48,984 DEBUG : BROWSER_OUTPUT: 13:51:48 INFO - 2015-12-14 13:51:48,984 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4945.50 Median:5586.75 stddev:1483.18 (26.5%) stddev-sans-first:1445.85 13:51:48 INFO - 2015-12-14 13:51:48,984 DEBUG : BROWSER_OUTPUT: Values: 304.0 311.1 315.0 318.8 320.7 5578.4 5735.7 5745.2 5748.4 5767.9 5595.1 5606.1 5628.3 5634.0 5636.6 4183.8 4298.6 4356.1 4370.7 4373.5 4315.3 4336.5 4349.0 4359.1 4359.8 4295.4 4296.8 4298.6 4301.5 4307.0 4298.0 4298.1 4301.7 4304.2 4310.0 3600.0 3739.5 3747.1 3752.2 3753.5 5319.6 5344.6 5437.5 5444.5 5453.1 4962.1 4971.0 4977.1 4979.1 4986.3 5970.2 6006.5 6013.8 6014.1 6028.9 3993.2 4082.4 4083.9 4097.9 4098.8 6187.3 6300.6 6304.4 6306.2 6320.9 4187.3 4193.4 4198.8 4200.2 4201.8 4235.7 4242.3 4259.6 4268.5 4271.4 4800.0 4872.7 4926.7 4927.7 4932.2 5946.4 5952.9 5964.5 5967.0 5975.3 1482.5 1500.6 1506.8 1516.2 1520.1 1004.8 1007.8 1018.9 1021.8 1031.1 5228.2 5244.5 5257.2 5273.8 5276.3 6225.1 6227.6 6228.2 6228.2 6240.2 5236.4 5238.6 5241.1 5243.5 5246.9 3286.1 3349.2 3369.3 3369.8 3371.5 5681.7 5790.3 5827.0 5827.8 5885.1 6410.6 6440.3 6447.8 6472.3 6478.3 5871.1 5883.7 5885.5 5886.6 5886.7 6163.8 6279.5 6280.4 6288.2 6293.6 6104.8 6110.8 6120.2 6121.4 6133.5 5841.9 5846.0 5882.1 5886.4 5892.8 4152.6 4203.8 4206.9 4237.0 4253.0 6064.6 6265.6 6282.4 6290.5 6291.0 6033.0 6036.4 6041.3 6042.6 6044.9 6014.6 6039.1 6041.1 6042.8 6044.7 5696.1 5892.9 5896.4 5900.7 5901.9 6044.9 6046.0 6050.0 6065.2 6082.2 5932.7 5939.0 5943.9 5944.9 5952.2 13:51:48 INFO - 2015-12-14 13:51:48,984 DEBUG : BROWSER_OUTPUT: 13:51:48 INFO - 2015-12-14 13:51:48,984 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12165.58 Median:43799.34 stddev:13607.54 (31.1%) stddev-sans-first:13618.55 13:51:48 INFO - 2015-12-14 13:51:48,984 DEBUG : BROWSER_OUTPUT: Values: 716.5 775.4 777.8 790.9 800.8 12113.9 12244.6 12279.9 12283.8 12285.0 10964.6 11555.1 11795.4 11799.6 13013.3 806.7 820.3 821.5 821.8 823.6 809.7 814.1 815.9 815.9 816.4 842.1 844.5 845.6 846.2 848.1 835.1 837.1 839.7 841.0 841.9 617.0 620.8 621.3 624.4 625.3 10244.4 10339.4 10339.8 10360.2 10376.2 11386.0 11402.4 11506.8 11571.5 11585.5 9191.1 9240.9 9318.9 9320.2 9321.6 3197.4 3263.3 3271.0 3286.2 3340.0 37508.2 38579.4 38721.8 38730.6 38964.2 9044.6 9156.3 9273.1 9319.5 9502.0 15632.5 15717.1 15774.3 15788.4 15789.8 6014.9 6253.8 6538.6 6657.7 6662.9 3456.8 3623.3 3653.2 3705.1 3709.9 2727.0 2728.7 2757.7 2758.2 2760.7 482.2 488.5 488.6 492.8 512.2 464.9 609.0 622.2 629.9 634.1 7614.0 7644.8 7652.9 7754.9 7769.6 569.1 574.1 594.9 603.3 627.6 3609.7 3712.2 3729.9 3801.9 3807.1 47772.3 48373.8 48412.3 48590.0 48620.3 42536.4 42579.6 43836.6 44065.0 44456.0 39943.4 41226.4 43495.3 43762.1 43913.3 8185.5 8202.6 8325.9 8397.9 8506.4 31943.8 32077.4 32089.5 32131.5 32505.7 37010.3 38635.8 38833.6 39123.6 39304.6 10211.8 10321.2 10388.6 10619.8 10837.3 10460.6 10667.9 11333.9 11351.7 12200.9 10671.9 10760.2 10790.3 10836.5 11223.7 10105.8 10611.3 10697.8 10745.8 11045.3 10588.7 10626.9 10639.9 10687.9 10891.5 8890.0 9279.7 9469.9 9508.4 9618.0 8532.1 8821.1 8867.6 8939.5 8947.6 13:51:48 INFO - 2015-12-14 13:51:48,984 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:51:48 INFO - 2015-12-14 13:51:48,984 DEBUG : BROWSER_OUTPUT: 13:51:49 INFO - 2015-12-14 13:51:49,671 INFO : Browser exited with error code: 0 13:51:49 INFO - 2015-12-14 13:51:49,692 INFO : Completed test dromaeo_css (00:18:34) 13:51:49 INFO - 2015-12-14 13:51:49,692 INFO : Starting test kraken 13:51:49 INFO - 2015-12-14 13:51:49,692 DEBUG : operating with platform_type : linux_ 13:51:49 INFO - 2015-12-14 13:51:49,693 INFO : Initialising browser for kraken test... 13:51:49 INFO - 2015-12-14 13:51:49,699 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvZDBh4/profile http://localhost:36894/getInfo.html 13:51:54 INFO - 2015-12-14 13:51:54,166 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:51:54 INFO - 2015-12-14 13:51:54,166 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:51:54 INFO - 2015-12-14 13:51:54,166 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:51:54 INFO - 2015-12-14 13:51:54,166 DEBUG : BROWSER_OUTPUT: __metrics 13:51:54 INFO - 2015-12-14 13:51:54,309 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 13:51:55 INFO - 2015-12-14 13:51:55,159 INFO : Browser initialized. 13:51:55 INFO - 2015-12-14 13:51:55,160 INFO : Running cycle 1/1 for kraken test... 13:51:55 INFO - 2015-12-14 13:51:55,160 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvZDBh4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:52:07 INFO - 2015-12-14 13:52:07,200 DEBUG : BROWSER_OUTPUT: RSS: Main: 143777792 13:52:07 INFO - 2015-12-14 13:52:07,200 DEBUG : BROWSER_OUTPUT: 13:52:09 INFO - 2015-12-14 13:52:09,776 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36894/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36894/tests/kraken/driver.html?testName=audio-beat-detection) 13:52:10 INFO - 2015-12-14 13:52:10,398 DEBUG : BROWSER_OUTPUT: RSS: Main: 142442496 13:52:10 INFO - 2015-12-14 13:52:10,398 DEBUG : BROWSER_OUTPUT: 13:52:13 INFO - 2015-12-14 13:52:13,163 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36894/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36894/tests/kraken/driver.html?testName=audio-dft) 13:52:13 INFO - 2015-12-14 13:52:13,769 DEBUG : BROWSER_OUTPUT: RSS: Main: 142905344 13:52:13 INFO - 2015-12-14 13:52:13,770 DEBUG : BROWSER_OUTPUT: 13:52:16 INFO - 2015-12-14 13:52:16,700 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36894/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36894/tests/kraken/driver.html?testName=audio-fft) 13:52:17 INFO - 2015-12-14 13:52:17,293 DEBUG : BROWSER_OUTPUT: RSS: Main: 138072064 13:52:17 INFO - 2015-12-14 13:52:17,293 DEBUG : BROWSER_OUTPUT: 13:52:19 INFO - 2015-12-14 13:52:19,327 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36894/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36894/tests/kraken/driver.html?testName=audio-oscillator) 13:52:19 INFO - 2015-12-14 13:52:19,912 DEBUG : BROWSER_OUTPUT: RSS: Main: 139239424 13:52:19 INFO - 2015-12-14 13:52:19,912 DEBUG : BROWSER_OUTPUT: 13:52:22 INFO - 2015-12-14 13:52:22,167 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36894/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36894/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:52:22 INFO - 2015-12-14 13:52:22,750 DEBUG : BROWSER_OUTPUT: RSS: Main: 140181504 13:52:22 INFO - 2015-12-14 13:52:22,750 DEBUG : BROWSER_OUTPUT: 13:52:25 INFO - 2015-12-14 13:52:25,821 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36894/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36894/tests/kraken/driver.html?testName=imaging-darkroom) 13:52:26 INFO - 2015-12-14 13:52:26,414 DEBUG : BROWSER_OUTPUT: RSS: Main: 140775424 13:52:26 INFO - 2015-12-14 13:52:26,416 DEBUG : BROWSER_OUTPUT: 13:52:29 INFO - 2015-12-14 13:52:29,870 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36894/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36894/tests/kraken/driver.html?testName=imaging-desaturate) 13:52:30 INFO - 2015-12-14 13:52:30,463 DEBUG : BROWSER_OUTPUT: RSS: Main: 140865536 13:52:30 INFO - 2015-12-14 13:52:30,464 DEBUG : BROWSER_OUTPUT: 13:52:33 INFO - 2015-12-14 13:52:33,307 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36894/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36894/tests/kraken/driver.html?testName=json-parse-financial) 13:52:33 INFO - 2015-12-14 13:52:33,909 DEBUG : BROWSER_OUTPUT: RSS: Main: 141238272 13:52:33 INFO - 2015-12-14 13:52:33,909 DEBUG : BROWSER_OUTPUT: 13:52:35 INFO - 2015-12-14 13:52:35,659 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36894/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36894/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:52:36 INFO - 2015-12-14 13:52:36,245 DEBUG : BROWSER_OUTPUT: RSS: Main: 141201408 13:52:36 INFO - 2015-12-14 13:52:36,245 DEBUG : BROWSER_OUTPUT: 13:52:38 INFO - 2015-12-14 13:52:38,136 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36894/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36894/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:52:38 INFO - 2015-12-14 13:52:38,764 DEBUG : BROWSER_OUTPUT: RSS: Main: 141127680 13:52:38 INFO - 2015-12-14 13:52:38,764 DEBUG : BROWSER_OUTPUT: 13:52:40 INFO - 2015-12-14 13:52:40,906 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36894/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36894/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:52:41 INFO - 2015-12-14 13:52:41,508 DEBUG : BROWSER_OUTPUT: RSS: Main: 140779520 13:52:41 INFO - 2015-12-14 13:52:41,508 DEBUG : BROWSER_OUTPUT: 13:52:44 INFO - 2015-12-14 13:52:44,109 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36894/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36894/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:52:44 INFO - 2015-12-14 13:52:44,715 DEBUG : BROWSER_OUTPUT: RSS: Main: 141099008 13:52:44 INFO - 2015-12-14 13:52:44,715 DEBUG : BROWSER_OUTPUT: 13:52:47 INFO - 2015-12-14 13:52:47,351 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36894/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36894/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:52:47 INFO - 2015-12-14 13:52:47,944 DEBUG : BROWSER_OUTPUT: RSS: Main: 140959744 13:52:47 INFO - 2015-12-14 13:52:47,945 DEBUG : BROWSER_OUTPUT: 13:52:49 INFO - 2015-12-14 13:52:49,734 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36894/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36894/tests/kraken/driver.html?testName=ai-astar) 13:52:49 INFO - 2015-12-14 13:52:49,984 DEBUG : BROWSER_OUTPUT: RSS: Main: 141590528 13:52:49 INFO - 2015-12-14 13:52:49,985 DEBUG : BROWSER_OUTPUT: 13:52:49 INFO - 2015-12-14 13:52:49,985 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:52:49 INFO - 2015-12-14 13:52:49,985 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:52:49 INFO - 2015-12-14 13:52:49,985 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:52:49 INFO - 2015-12-14 13:52:49,986 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:52:49 INFO - 2015-12-14 13:52:49,986 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;109;113;113;113;125;114;113;111;113 13:52:49 INFO - 2015-12-14 13:52:49,986 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;163;135;154;166;131;160;162;138;174;137 13:52:49 INFO - 2015-12-14 13:52:49,986 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;163;162;160;162;164;172;164;164;164 13:52:49 INFO - 2015-12-14 13:52:49,986 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;73;72;73;128;74;78;72;72 13:52:49 INFO - 2015-12-14 13:52:49,986 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;95;132;94;94;94;138;96;95;127 13:52:49 INFO - 2015-12-14 13:52:49,986 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;113;110;110;110;110;111;111;110;111;110 13:52:49 INFO - 2015-12-14 13:52:49,987 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;148;148;147;148;147;148;147;147;148 13:52:49 INFO - 2015-12-14 13:52:49,987 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;98;96;96;96;96;96;96;95 13:52:49 INFO - 2015-12-14 13:52:49,987 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;74;75;73;72;72;73;73;75;72;72 13:52:49 INFO - 2015-12-14 13:52:49,987 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;69;69;68;69;69;69;68;68;67 13:52:49 INFO - 2015-12-14 13:52:49,987 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;85;84;87;84;93;84;86;85;87 13:52:49 INFO - 2015-12-14 13:52:49,987 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;131;127;123;126;120;124;150;129;141;130 13:52:49 INFO - 2015-12-14 13:52:49,987 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;140;149;149;151;154;155;151;144;148;137 13:52:49 INFO - 2015-12-14 13:52:49,987 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;73;73;70;71;71;70;71;69;71;69 13:52:49 INFO - 2015-12-14 13:52:49,987 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:52:49 INFO - 2015-12-14 13:52:49,987 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:52:49 INFO - 2015-12-14 13:52:49,987 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,808 13:52:49 INFO - 2015-12-14 13:52:49,987 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:52:49 INFO - 2015-12-14 13:52:49,987 DEBUG : BROWSER_OUTPUT: __startTimestamp1450129969983__endTimestamp 13:52:49 INFO - 2015-12-14 13:52:49,987 DEBUG : BROWSER_OUTPUT: 13:52:49 INFO - 2015-12-14 13:52:49,991 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:52:49 INFO - 2015-12-14 13:52:49,991 DEBUG : BROWSER_OUTPUT: Number of tests: 14 13:52:49 INFO - 2015-12-14 13:52:49,991 DEBUG : BROWSER_OUTPUT: 13:52:49 INFO - 2015-12-14 13:52:49,991 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:113.60 Median:113.00 stddev:4.25 (3.8%) stddev-sans-first:4.47 13:52:49 INFO - 2015-12-14 13:52:49,991 DEBUG : BROWSER_OUTPUT: Values: 112.0 109.0 113.0 113.0 113.0 125.0 114.0 113.0 111.0 113.0 13:52:49 INFO - 2015-12-14 13:52:49,991 DEBUG : BROWSER_OUTPUT: 13:52:49 INFO - 2015-12-14 13:52:49,991 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:152.00 Median:161.00 stddev:15.35 (9.5%) stddev-sans-first:15.75 13:52:49 INFO - 2015-12-14 13:52:49,991 DEBUG : BROWSER_OUTPUT: Values: 163.0 135.0 154.0 166.0 131.0 160.0 162.0 138.0 174.0 137.0 13:52:49 INFO - 2015-12-14 13:52:49,991 DEBUG : BROWSER_OUTPUT: 13:52:49 INFO - 2015-12-14 13:52:49,991 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.80 Median:164.00 stddev:3.16 (1.9%) stddev-sans-first:3.33 13:52:49 INFO - 2015-12-14 13:52:49,992 DEBUG : BROWSER_OUTPUT: Values: 163.0 163.0 162.0 160.0 162.0 164.0 172.0 164.0 164.0 164.0 13:52:49 INFO - 2015-12-14 13:52:49,992 DEBUG : BROWSER_OUTPUT: 13:52:49 INFO - 2015-12-14 13:52:49,992 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:78.60 Median:72.50 stddev:17.46 (24.1%) stddev-sans-first:18.35 13:52:49 INFO - 2015-12-14 13:52:49,992 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 73.0 72.0 73.0 128.0 74.0 78.0 72.0 72.0 13:52:49 INFO - 2015-12-14 13:52:49,992 DEBUG : BROWSER_OUTPUT: 13:52:49 INFO - 2015-12-14 13:52:49,992 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.90 Median:94.00 stddev:18.44 (19.6%) stddev-sans-first:19.04 13:52:49 INFO - 2015-12-14 13:52:49,992 DEBUG : BROWSER_OUTPUT: Values: 94.0 95.0 132.0 94.0 94.0 94.0 138.0 96.0 95.0 127.0 13:52:49 INFO - 2015-12-14 13:52:49,992 DEBUG : BROWSER_OUTPUT: 13:52:49 INFO - 2015-12-14 13:52:49,992 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.60 Median:110.50 stddev:0.97 (0.9%) stddev-sans-first:0.50 13:52:49 INFO - 2015-12-14 13:52:49,992 DEBUG : BROWSER_OUTPUT: Values: 113.0 110.0 110.0 110.0 110.0 111.0 111.0 110.0 111.0 110.0 13:52:49 INFO - 2015-12-14 13:52:49,992 DEBUG : BROWSER_OUTPUT: 13:52:49 INFO - 2015-12-14 13:52:49,992 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.52 (0.3%) stddev-sans-first:0.53 13:52:49 INFO - 2015-12-14 13:52:49,993 DEBUG : BROWSER_OUTPUT: Values: 148.0 148.0 148.0 147.0 148.0 147.0 148.0 147.0 147.0 148.0 13:52:49 INFO - 2015-12-14 13:52:49,993 DEBUG : BROWSER_OUTPUT: 13:52:49 INFO - 2015-12-14 13:52:49,993 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 13:52:49 INFO - 2015-12-14 13:52:49,993 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 98.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 13:52:49 INFO - 2015-12-14 13:52:49,993 DEBUG : BROWSER_OUTPUT: 13:52:49 INFO - 2015-12-14 13:52:49,993 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.10 Median:73.00 stddev:1.20 (1.6%) stddev-sans-first:1.22 13:52:49 INFO - 2015-12-14 13:52:49,993 DEBUG : BROWSER_OUTPUT: Values: 74.0 75.0 73.0 72.0 72.0 73.0 73.0 75.0 72.0 72.0 13:52:49 INFO - 2015-12-14 13:52:49,993 DEBUG : BROWSER_OUTPUT: 13:52:49 INFO - 2015-12-14 13:52:49,993 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:69.00 stddev:0.82 (1.2%) stddev-sans-first:0.73 13:52:49 INFO - 2015-12-14 13:52:49,993 DEBUG : BROWSER_OUTPUT: Values: 67.0 69.0 69.0 68.0 69.0 69.0 69.0 68.0 68.0 67.0 13:52:49 INFO - 2015-12-14 13:52:49,994 DEBUG : BROWSER_OUTPUT: 13:52:49 INFO - 2015-12-14 13:52:49,994 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:85.50 stddev:2.77 (3.2%) stddev-sans-first:2.85 13:52:49 INFO - 2015-12-14 13:52:49,994 DEBUG : BROWSER_OUTPUT: Values: 84.0 85.0 84.0 87.0 84.0 93.0 84.0 86.0 85.0 87.0 13:52:49 INFO - 2015-12-14 13:52:49,994 DEBUG : BROWSER_OUTPUT: 13:52:49 INFO - 2015-12-14 13:52:49,994 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:130.10 Median:129.50 stddev:9.02 (7.0%) stddev-sans-first:9.57 13:52:49 INFO - 2015-12-14 13:52:49,994 DEBUG : BROWSER_OUTPUT: Values: 131.0 127.0 123.0 126.0 120.0 124.0 150.0 129.0 141.0 130.0 13:52:49 INFO - 2015-12-14 13:52:49,994 DEBUG : BROWSER_OUTPUT: 13:52:49 INFO - 2015-12-14 13:52:49,994 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.80 Median:150.00 stddev:5.83 (3.9%) stddev-sans-first:5.45 13:52:49 INFO - 2015-12-14 13:52:49,994 DEBUG : BROWSER_OUTPUT: Values: 140.0 149.0 149.0 151.0 154.0 155.0 151.0 144.0 148.0 137.0 13:52:49 INFO - 2015-12-14 13:52:49,994 DEBUG : BROWSER_OUTPUT: 13:52:49 INFO - 2015-12-14 13:52:49,995 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.80 Median:71.00 stddev:1.40 (2.0%) stddev-sans-first:1.24 13:52:49 INFO - 2015-12-14 13:52:49,995 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 70.0 71.0 71.0 70.0 71.0 69.0 71.0 69.0 13:52:49 INFO - 2015-12-14 13:52:49,995 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:52:49 INFO - 2015-12-14 13:52:49,995 DEBUG : BROWSER_OUTPUT: 13:52:50 INFO - 2015-12-14 13:52:50,907 INFO : Browser exited with error code: 0 13:52:50 INFO - 2015-12-14 13:52:50,960 INFO : Completed test kraken (00:01:01) 13:52:50 INFO - 2015-12-14 13:52:50,960 INFO : Starting test v8_7 13:52:50 INFO - 2015-12-14 13:52:50,960 DEBUG : operating with platform_type : linux_ 13:52:50 INFO - 2015-12-14 13:52:50,960 INFO : Initialising browser for v8_7 test... 13:52:50 INFO - 2015-12-14 13:52:50,966 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOk2VtL/profile http://localhost:36894/getInfo.html 13:52:55 INFO - 2015-12-14 13:52:55,568 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:52:55 INFO - 2015-12-14 13:52:55,568 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:52:55 INFO - 2015-12-14 13:52:55,568 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:52:55 INFO - 2015-12-14 13:52:55,568 DEBUG : BROWSER_OUTPUT: __metrics 13:52:55 INFO - 2015-12-14 13:52:55,737 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 13:52:56 INFO - 2015-12-14 13:52:56,747 INFO : Browser initialized. 13:52:56 INFO - 2015-12-14 13:52:56,748 INFO : Running cycle 1/1 for v8_7 test... 13:52:56 INFO - 2015-12-14 13:52:56,748 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOk2VtL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:53:08 INFO - 2015-12-14 13:53:08,776 DEBUG : BROWSER_OUTPUT: RSS: Main: 143183872 13:53:08 INFO - 2015-12-14 13:53:08,777 DEBUG : BROWSER_OUTPUT: 13:53:30 INFO - 2015-12-14 13:53:30,277 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36894/tests/v8_7/run.html (next: http://localhost:36894/tests/v8_7/run.html) 13:53:30 INFO - 2015-12-14 13:53:30,520 DEBUG : BROWSER_OUTPUT: RSS: Main: 138252288 13:53:30 INFO - 2015-12-14 13:53:30,521 DEBUG : BROWSER_OUTPUT: 13:53:30 INFO - 2015-12-14 13:53:30,522 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:53:30 INFO - 2015-12-14 13:53:30,522 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:53:30 INFO - 2015-12-14 13:53:30,522 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:53:30 INFO - 2015-12-14 13:53:30,522 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:53:30 INFO - 2015-12-14 13:53:30,522 DEBUG : BROWSER_OUTPUT: |0;Richards;167.11229946524065 13:53:30 INFO - 2015-12-14 13:53:30,523 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.1851851851852 13:53:30 INFO - 2015-12-14 13:53:30,523 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.623542476402 13:53:30 INFO - 2015-12-14 13:53:30,523 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5175.257731958763 13:53:30 INFO - 2015-12-14 13:53:30,523 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1048.1675392670156 13:53:30 INFO - 2015-12-14 13:53:30,523 DEBUG : BROWSER_OUTPUT: |5;Earley;723.589001447178 13:53:30 INFO - 2015-12-14 13:53:30,523 DEBUG : BROWSER_OUTPUT: |6;Boyer;12231.707317073171 13:53:30 INFO - 2015-12-14 13:53:30,523 DEBUG : BROWSER_OUTPUT: |7;RegExp;26051.28205128205 13:53:30 INFO - 2015-12-14 13:53:30,524 DEBUG : BROWSER_OUTPUT: |8;Splay;597.3715651135007 13:53:30 INFO - 2015-12-14 13:53:30,524 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 13:53:30 INFO - 2015-12-14 13:53:30,524 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:53:30 INFO - 2015-12-14 13:53:30,524 DEBUG : BROWSER_OUTPUT: __startTimestamp1450130010521__endTimestamp 13:53:30 INFO - 2015-12-14 13:53:30,524 DEBUG : BROWSER_OUTPUT: 13:53:30 INFO - 2015-12-14 13:53:30,525 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:53:30 INFO - 2015-12-14 13:53:30,526 DEBUG : BROWSER_OUTPUT: Number of tests: 10 13:53:30 INFO - 2015-12-14 13:53:30,526 DEBUG : BROWSER_OUTPUT: 13:53:30 INFO - 2015-12-14 13:53:30,526 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.11 Median:167.11 stddev:0.00 (0.0%) 13:53:30 INFO - 2015-12-14 13:53:30,526 DEBUG : BROWSER_OUTPUT: Values: 167.1 13:53:30 INFO - 2015-12-14 13:53:30,526 DEBUG : BROWSER_OUTPUT: 13:53:30 INFO - 2015-12-14 13:53:30,527 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.19 Median:185.19 stddev:0.00 (0.0%) 13:53:30 INFO - 2015-12-14 13:53:30,527 DEBUG : BROWSER_OUTPUT: Values: 185.2 13:53:30 INFO - 2015-12-14 13:53:30,527 DEBUG : BROWSER_OUTPUT: 13:53:30 INFO - 2015-12-14 13:53:30,527 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.62 Median:277.62 stddev:0.00 (0.0%) 13:53:30 INFO - 2015-12-14 13:53:30,527 DEBUG : BROWSER_OUTPUT: Values: 277.6 13:53:30 INFO - 2015-12-14 13:53:30,527 DEBUG : BROWSER_OUTPUT: 13:53:30 INFO - 2015-12-14 13:53:30,528 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5175.26 Median:5175.26 stddev:0.00 (0.0%) 13:53:30 INFO - 2015-12-14 13:53:30,528 DEBUG : BROWSER_OUTPUT: Values: 5175.3 13:53:30 INFO - 2015-12-14 13:53:30,528 DEBUG : BROWSER_OUTPUT: 13:53:30 INFO - 2015-12-14 13:53:30,528 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1048.17 Median:1048.17 stddev:0.00 (0.0%) 13:53:30 INFO - 2015-12-14 13:53:30,528 DEBUG : BROWSER_OUTPUT: Values: 1048.2 13:53:30 INFO - 2015-12-14 13:53:30,528 DEBUG : BROWSER_OUTPUT: 13:53:30 INFO - 2015-12-14 13:53:30,528 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:723.59 Median:723.59 stddev:0.00 (0.0%) 13:53:30 INFO - 2015-12-14 13:53:30,528 DEBUG : BROWSER_OUTPUT: Values: 723.6 13:53:30 INFO - 2015-12-14 13:53:30,529 DEBUG : BROWSER_OUTPUT: 13:53:30 INFO - 2015-12-14 13:53:30,529 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12231.71 Median:12231.71 stddev:0.00 (0.0%) 13:53:30 INFO - 2015-12-14 13:53:30,529 DEBUG : BROWSER_OUTPUT: Values: 12231.7 13:53:30 INFO - 2015-12-14 13:53:30,529 DEBUG : BROWSER_OUTPUT: 13:53:30 INFO - 2015-12-14 13:53:30,529 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26051.28 Median:26051.28 stddev:0.00 (0.0%) 13:53:30 INFO - 2015-12-14 13:53:30,529 DEBUG : BROWSER_OUTPUT: Values: 26051.3 13:53:30 INFO - 2015-12-14 13:53:30,529 DEBUG : BROWSER_OUTPUT: 13:53:30 INFO - 2015-12-14 13:53:30,530 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:597.37 Median:597.37 stddev:0.00 (0.0%) 13:53:30 INFO - 2015-12-14 13:53:30,530 DEBUG : BROWSER_OUTPUT: Values: 597.4 13:53:30 INFO - 2015-12-14 13:53:30,530 DEBUG : BROWSER_OUTPUT: 13:53:30 INFO - 2015-12-14 13:53:30,530 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 13:53:30 INFO - 2015-12-14 13:53:30,530 DEBUG : BROWSER_OUTPUT: Values: 4835.7 13:53:30 INFO - 2015-12-14 13:53:30,530 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:53:30 INFO - 2015-12-14 13:53:30,530 DEBUG : BROWSER_OUTPUT: 13:53:31 INFO - 2015-12-14 13:53:31,487 INFO : Browser exited with error code: 0 13:53:31 INFO - 2015-12-14 13:53:31,499 INFO : Completed test v8_7 (00:00:40) 13:53:31 INFO - 2015-12-14 13:53:31,508 INFO : Completed test suite (00:20:16) 13:53:31 INFO - 2015-12-14 13:53:31,508 DEBUG : Working with test: dromaeo_css 13:53:31 INFO - 2015-12-14 13:53:31,508 DEBUG : Generating results file: dromaeo_css 13:53:31 INFO - 2015-12-14 13:53:31,509 DEBUG : Working with test: kraken 13:53:31 INFO - 2015-12-14 13:53:31,509 DEBUG : Generating results file: kraken 13:53:31 INFO - 2015-12-14 13:53:31,510 INFO : javascript benchmark 13:53:31 INFO - 2015-12-14 13:53:31,510 DEBUG : Working with test: v8_7 13:53:31 INFO - 2015-12-14 13:53:31,510 DEBUG : Generating results file: v8_7 13:53:31 INFO - 2015-12-14 13:53:31,510 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:53:31 INFO - 2015-12-14 13:53:31,576 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,43]] 13:53:31 INFO - 2015-12-14 13:53:31,576 DEBUG : process_Request line: dromaeo_css 6471.92 graph.html#tests=[[72,94,43]] 13:53:31 INFO - 2015-12-14 13:53:31,576 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:53:31 INFO - 2015-12-14 13:53:31,610 DEBUG : process_Request line: kraken 1544.20 graph.html#tests=[[232,94,43]] 13:53:31 INFO - 2015-12-14 13:53:31,610 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:53:31 INFO - 2015-12-14 13:53:31,647 DEBUG : process_Request line: v8_7 21394.39 graph.html#tests=[[230,94,43]] 13:53:31 INFO - 2015-12-14 13:53:31,648 INFO : javascript benchmark 13:53:31 INFO - 2015-12-14 13:53:31,652 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2679.4239238563705, 2721.945561088777, 2761.2406588188246, 2781.694013658497, 2782.4296019316057, 4647.070585882829, 4848.369711937447, 4851.878703032426, 4854.5388188122115, 4880.170371036923, 4705.882352941178, 4749.762511874401, 4752.500987396317, 4808.759562021903, 4815.686980346275, 4389.495208051083, 4463.285874260119, 4549.408576885, 4552.544745525437, 4607.723536587799, 4256.659467242629, 4515.345274935133, 4551.499335073139, 4563.110193512266, 4652.046330502239, 4313.245182093121, 4350.15172041452, 4377.824887004516, 4399.978000110011, 4442.311441726538, 4482.8655140345845, 4500.684952053325, 4503.256962601167, 4504.369388285642, 4552.817887284505, 4295.828166873322, 4385.627221686161, 4445.644348452116, 4457.7651231330365, 4487.865364039084, 4595.919958809677, 4660.836870709509, 4670.626349892001, 4710.3641008463765, 4738.028704115648, 5146.3824341078935, 5180.041692286939, 5185.351831021122, 5186.5850731941355, 5187.04039752647, 4956.950430495685, 5048.242763585455, 5056.62075344347, 5208.635395522315, 5280.471952804727, 4805.255185446262, 4820.68665536739, 4822.469528351879, 4869.099216644897, 4874.439439464436, 5324.547413469821, 5327.200919862052, 5328.733563321818, 5329.040772660881, 5334.0, 4858.6356023297685, 4954.504549545089, 5023.773930173151, 5113.079645663742, 5121.615878809104, 5184.559312458483, 5206.817761378409, 5209.921851172236, 5216.295800066942, 5234.842954711288, 5158.97420512895, 5165.070287348238, 5173.1722924331925, 5184.481551844785, 5200.193969934666, 4799.448063472675, 4895.6083513318845, 5041.8487445376695, 5108.182690769459, 5135.409427915837, 4280.957190428056, 4333.046729719456, 4339.067100573392, 4346.282863327516, 4375.343698445195, 3584.0143960411096, 3808.447775072599, 3809.3333666608232, 3834.501514803058, 3857.8263978121054, 4423.911521769546, 4475.373447717322, 4483.0, 4541.886452838706, 4569.817207311737, 5182.067227899014, 5223.373195216523, 5227.477252274818, 5240.528352448222, 5241.947580524222, 4323.762193079411, 4417.580329868657, 4502.3246513023305, 4520.254158063948, 4577.1074640444795, 4532.388127602731, 4607.516210797885, 4618.607418369476, 4634.351190833286, 4674.626029917598, 4878.536539028786, 4913.336699545515, 4933.407991041098, 4945.5301746333325, 4960.0327936052845, 4908.165611845923, 5024.698518088926, 5107.361579802525, 5252.2646829444675, 5291.867703307448, 4861.222204447272, 4888.319022934898, 4932.235503496964, 4935.580475659609, 4947.82682606107, 5088.262201980618, 5103.055934652101, 5119.5648369887485, 5131.846044618667, 5133.922991155061, 5031.119554078095, 5125.615578831528, 5138.794448222029, 5197.324347834758, 5237.135872581134, 4981.501849814989, 5041.991601679752, 5070.518300761421, 5077.644564880571, 5122.436531981553, 5037.798488060583, 5050.823221187241, 5068.619853511075, 5080.237964305236, 5087.720175390241, 4676.228422310281, 4754.025424787841, 4825.0, 4923.163062279349, 4940.333055037524, 5054.368203974504, 5118.718470484159, 5130.204818253177, 5140.0, 5144.6655967362, 4702.388689470347, 4996.725180115129, 5001.274815151855, 5006.974965125151, 5028.220625803006], "unit": "ms", "name": "dojo.html", "value": 4736.325428120619}, {"lowerIsBetter": false, "replicates": [557.0057447456294, 559.0551967175473, 564.4553006348873, 568.272611057846, 571.1432850723914, 35454.0, 36088.278234435325, 36111.81944090276, 36157.819210903945, 36236.45645315316, 39548.406773898416, 39711.80144099276, 40115.598844011554, 40168.39747403784, 40252.0, 7870.606469676508, 8052.5973701315, 8084.989376327959, 8090.757277281661, 8095.433319667625, 7872.212778722139, 7958.045034595857, 7977.920220797805, 7978.880316795224, 7979.800504987393, 7909.327707144871, 7973.083095444011, 7979.162187970267, 7990.800229994267, 7993.680252789882, 7908.802279943019, 7957.522548647042, 7960.24377684122, 8001.719939802079, 8006.719764808204, 7791.571463569501, 7862.174471680506, 7883.054033515958, 7898.447108702393, 7906.248906353945, 36835.0, 37338.81330593357, 37529.249415011545, 37557.24885502302, 37586.24827503462, 2386.7971222446113, 2888.768898488116, 2969.747571456429, 3071.0, 3129.0769223079246, 26570.0, 30082.09753707392, 30947.535786963213, 31499.0, 32271.0, 3380.678835510623, 3392.5928888533285, 3421.6920477156928, 3467.5665541807275, 3475.565554305712, 172636.0, 173990.1300493502, 174570.0, 175108.0, 175206.0, 45367.546324536335, 46484.97847639892, 48890.26664600034, 49430.75284623554, 53427.0, 47139.76430117896, 47248.291275630894, 47273.290900636515, 47316.29025564619, 47342.526574734504, 12063.215890967234, 12081.154319197747, 12123.515059397525, 12202.572909948109, 12253.632391028283, 9245.306602004877, 9294.209992150743, 9310.86033709495, 9310.906890931139, 9345.813083738287, 17661.470155895342, 17902.5524361892, 17953.102344882704, 17983.280668773103, 18071.0, 7568.129665088585, 7799.493032952953, 7861.646225919847, 7905.446618736633, 7963.681452741941, 870.7257213977576, 908.981820363589, 918.8575770755543, 958.7890664053897, 985.8028394321165, 27240.72759272382, 27331.86334068357, 27403.45193096127, 28919.252670996222, 31151.221219469695, 947.8767760191131, 977.2084611464736, 1028.6194108179873, 1037.6368271105205, 1085.9619913302997, 12990.220586764824, 13192.274424906722, 13271.73456530864, 13280.73438531224, 13352.0, 316944.0, 321065.0, 321196.54615542357, 323203.0, 323929.0, 44988.77505612451, 45211.773941130086, 45278.32082518765, 45484.545154548694, 45520.77239613781, 1121.198343184627, 1221.1268942706008, 1240.8200810882372, 1242.2608547913976, 1344.9663758405923, 26904.865475672497, 27329.180124596292, 27691.307717306423, 27694.861525692242, 27765.305867353476, 37356.62643373531, 37573.62426375701, 37616.62383376241, 37636.435453467675, 37847.43228851625, 180305.0, 180530.0, 182711.0, 183008.0, 185834.0, 28590.426861582557, 29252.268693282836, 29390.706092938795, 29425.0, 29479.557806633347, 37406.251874962894, 37565.81217093897, 38063.80968095142, 38359.61640383561, 38534.0, 32123.839380802947, 32164.839175803972, 32750.50874236936, 32891.17772055718, 32937.34125317432, 32989.0, 33078.0, 33323.50014749829, 33414.498782517796, 33523.83238083892, 32176.35647287088, 32393.352132956737, 32417.51373729443, 38087.42868856914, 38992.0, 28412.857935710188, 29642.0, 30489.847550762104, 34514.654853451146, 35508.0, 23819.52360952806, 23854.284371468882, 23860.403489912893, 23885.761142388354, 24096.0], "unit": "ms", "name": "ext.html", "value": 16520.079848749247}, {"lowerIsBetter": false, "replicates": [331.29599600848206, 331.40181971541364, 332.70721764846945, 335.3276680256086, 337.25466718551996, 15286.84713152868, 15548.378064877406, 15809.367625294974, 16681.83318166818, 17193.656126877457, 9982.950085249564, 10208.591656333756, 13691.863081369183, 14859.182744949023, 14903.10581365119, 4458.531854155308, 4525.886852828673, 4638.55933686301, 5190.195519694435, 5214.4524824893215, 5114.053900028488, 5136.152534831767, 5149.974250128744, 5156.123459011958, 5156.149235376159, 5078.49215078491, 5108.540231379176, 6084.391560843925, 6217.906731399033, 6219.880421524123, 6138.17134686816, 6160.383961603826, 6188.47397971173, 6212.223472065992, 6389.424951754364, 6079.665618390986, 6101.633901965896, 6122.47958923492, 6131.14164017038, 6135.938640613626, 21373.46566335854, 21661.783382166293, 21718.348449546538, 22552.0, 22580.322590322317, 1806.9367572134913, 1862.9068546572616, 1917.5809900673542, 1951.7267582538313, 1967.2032826705208, 14182.787258191032, 14205.715885682332, 14222.288885555681, 14390.928045359811, 14483.832024663508, 1874.8406385457251, 1922.0774028466415, 1931.5750534882304, 1935.4290484307164, 1950.1906708715867, 60790.0, 65173.674131629516, 65451.345486545004, 65512.67243663751, 65855.3414465854, 15936.442224522087, 15986.280617372246, 16041.197940102948, 16092.919535402249, 16293.34826606946, 23519.294421167393, 23544.64683029756, 23630.29109126729, 23768.0, 23769.524609507713, 7833.099193592696, 7916.762497125095, 7961.761147165478, 7985.72049978248, 8115.310198633064, 6326.145970294044, 6396.872062558816, 6453.193350831146, 6477.740890364333, 6524.739010439529, 7881.014873140857, 7899.565523896241, 7914.129445760962, 7989.201079891965, 8016.7194148204535, 1738.4610770661136, 1814.7005744052346, 3021.773366997484, 3172.730317922956, 3279.4588892832894, 802.6468353924255, 835.1398059998212, 929.8884133903839, 972.1202311907734, 992.831218692824, 14881.404743810343, 14938.925305373403, 15852.52442426729, 16311.0, 16433.178341082898, 831.7754206364368, 843.6836186430089, 915.1031988651159, 922.5341202692597, 970.96601618943, 9136.451812891248, 9293.535323233811, 9299.395539289924, 9367.344285899922, 9396.953015235016, 440164.0, 440831.0, 446277.0, 448626.0, 449607.0, 66671.66664166746, 69596.6520167396, 70360.0, 71472.64263678648, 71660.28339716536, 1056.392574269798, 1066.7546464313252, 1068.460427484131, 1073.0557109743531, 1078.8867168947147, 14031.228282444155, 14198.858011420167, 14266.643333916734, 14447.422103115758, 15061.0, 32018.839905800323, 32034.03897883067, 32273.51589726203, 32735.83632081824, 33328.50007249942, 43383.34924976065, 43701.0, 43799.781001094794, 44083.55916440795, 45792.77103614461, 8693.521856297964, 8949.642014319354, 9006.954965225394, 9101.40840845343, 9138.680146195116, 10559.419231942316, 12323.938380308042, 15949.362025518849, 16710.66578668444, 16760.245788939283, 13399.062065655311, 13407.0, 13833.170009799444, 14058.78911816344, 14119.788203177166, 13175.736485270432, 13461.932690336485, 13693.726125477633, 13769.31153442344, 13787.0, 13856.515021974183, 13988.860111399163, 14130.50543230982, 14388.640283992565, 14450.494232701805, 8922.286217102486, 9031.36780425364, 9059.365844391094, 9074.637014519345, 9132.452052876582, 9492.24393487207, 9667.9033209667, 9751.609935602497, 14257.572272831416, 14309.785353219502], "unit": "ms", "name": "jquery.html", "value": 9090.31965514115}, {"lowerIsBetter": false, "replicates": [1455.8325792533863, 1681.6720739455807, 1715.8970461772294, 1720.2602880761267, 1752.0538908989142, 6029.186059881915, 6216.378362163793, 7169.390601798847, 7355.668994895236, 7358.448116391265, 6763.323667633234, 6926.099607051089, 6971.0, 6983.7555685551015, 7003.0, 2037.103674383274, 2091.048572899327, 2092.016752126498, 2092.1108528875243, 2092.6337890869113, 2099.4751312171957, 2107.083418712865, 2113.3765539165906, 2150.6773983902463, 2151.7848215178437, 2127.0747224957117, 2145.570885822842, 2146.710194123789, 2165.8808765517892, 2173.3588591365506, 2100.1284466946277, 2118.947026324339, 2125.4048866317457, 2126.393977716343, 2127.755308139568, 2051.8461115416253, 2057.825084867773, 2057.86623869448, 2057.989710051455, 2062.2163577840324, 7230.132384113887, 7260.96369518149, 7278.9272107278775, 7286.052813134312, 7322.121345438582, 4066.34938409853, 4115.814788334532, 4123.927778777509, 4135.048938744106, 4146.212219678251, 2617.175589689242, 2636.7890568754647, 2724.5913113033007, 2727.6454060971946, 2732.562789953598, 819.2053707903324, 834.0658462521953, 839.8068444257793, 849.3544905871582, 856.208007592974, 9602.231821454267, 9621.230301575857, 9649.758756031155, 9697.466639334903, 9711.27165462593, 3860.517435320585, 3863.188730366598, 3917.6474117329576, 3944.684425245973, 3963.4649322341115, 8341.290990265774, 8388.37087218461, 8398.748037558884, 8400.495970241805, 8403.159684031549, 4310.741355518679, 4318.3090705486975, 4330.437043184429, 4350.456192975878, 4360.869173924787, 3322.9335413291597, 3404.38721030212, 3917.138229589486, 3925.450436938831, 3929.8821035368983, 3395.168183794986, 3414.3171365726953, 3433.8626454941523, 3438.948415773765, 3443.328550932544, 1084.7938891610568, 1102.8456016157745, 1109.2678831970861, 1110.5779803674714, 1111.0944580167138, 1007.37039350406, 1008.3496144986443, 1012.6556970629874, 1015.1979935850743, 1057.7672911959357, 6748.291429399842, 6765.661716914135, 6766.560173588701, 6770.763023294161, 6789.72841086351, 432.34499732904675, 439.18969501270107, 442.7498463368187, 443.51656694203473, 445.1120015568961, 5285.947140528546, 5319.308489896289, 5333.626646134733, 5339.038972984822, 5344.91982620261, 8304.584770761438, 8688.78278043054, 8777.51723655205, 8788.516631585324, 8826.338024648048, 8507.149285071568, 8564.0, 8607.870881936777, 8644.827103458021, 8674.86987695185, 6735.124433823572, 6750.763723269662, 6852.725890964306, 6873.347032031849, 6877.2091209510545, 6440.549161558646, 6442.742290308335, 6451.806445806634, 6466.030095485715, 6483.870322593428, 7507.249275072449, 7760.6418876695225, 7768.378529717722, 7777.1833957433655, 7811.726589569338, 7672.6547305372505, 7980.521168729895, 7992.720254791055, 8004.959975200087, 8042.437029407885, 5333.493318134771, 5642.069058605284, 6126.1423400724825, 6359.523035772429, 6419.35806419373, 6564.80305590833, 6802.319768023158, 6826.078479405415, 6840.213375461686, 6845.726170953106, 6297.874042519033, 6363.936360636334, 6449.097126402401, 6562.212534495891, 6590.901136483052, 6293.811185664437, 6485.902711459237, 6488.772892948724, 6555.508336874658, 6591.406773390418, 6352.68236588178, 6372.904406433814, 6383.489320854228, 6390.488760899024, 6398.264199617103, 5918.852028699317, 5928.67392293428, 5961.0, 5977.940220597912, 5996.70016499182, 6148.108524263867, 6170.845728856814, 6212.099245609271, 6222.533310001678, 6247.0629405589525], "unit": "ms", "name": "mootools.html", "value": 4017.8951911601976}, {"lowerIsBetter": false, "replicates": [304.0498442367601, 311.14590449216905, 315.0391306515129, 318.7545589895779, 320.67451536690277, 5578.386377498472, 5735.684537350444, 5745.195672605833, 5748.396418376073, 5767.884642307162, 5595.104783234683, 5606.074997625397, 5628.26832511774, 5634.04221282382, 5636.577256705753, 4183.832646694129, 4298.634616057639, 4356.1069980653965, 4370.7106403611015, 4373.518912919576, 4315.309550471925, 4336.522982471925, 4349.043210493702, 4359.106383191438, 4359.782010899458, 4295.441592592959, 4296.8281268749215, 4298.613124818766, 4301.483821941356, 4306.97846510767, 4297.957020429787, 4298.054428025829, 4301.698881078326, 4304.182205380967, 4310.030243195271, 3599.9560127562977, 3739.513863197767, 3747.1006958330076, 3752.249550089966, 3753.455748916419, 5319.5744340452675, 5344.625876188668, 5437.510624043855, 5444.50999410055, 5453.072977593779, 4962.106820772259, 4970.975145124287, 4977.129002424561, 4979.10376132296, 4986.276989836453, 5970.194023806774, 6006.489448396847, 6013.849653758647, 6014.067819487943, 6028.879422411527, 3993.221321842242, 4082.448869402622, 4083.9183216335805, 4097.8565750198895, 4098.774567398792, 6187.288461826903, 6300.621962682254, 6304.432601065881, 6306.243250809932, 6320.905186422207, 4187.309093999456, 4193.35003074524, 4198.769067701306, 4200.243956087872, 4201.810918508674, 4235.661147108224, 4242.342436922282, 4259.616634502848, 4268.509121451073, 4271.444712187458, 4800.0, 4872.658913875995, 4926.679765815211, 4927.704337739747, 4932.21084626458, 5946.405359464019, 5952.940470595326, 5964.522838172936, 5967.045272756425, 5975.342712301644, 1482.5181815909873, 1500.647347873249, 1506.8267149277754, 1516.196415899575, 1520.1107352198867, 1004.8442491413842, 1007.7883644434604, 1018.8624535687735, 1021.7854250607307, 1031.0874875734878, 5228.189630607262, 5244.5279924806955, 5257.185136303879, 5273.841784746463, 5276.261323414725, 6225.128482012522, 6227.564070515021, 6228.190335256388, 6228.22147231596, 6240.157578726905, 5236.423993360727, 5238.60710446718, 5241.135212689864, 5243.501867322599, 5246.895062098813, 3286.0963235110057, 3349.1794510344635, 3369.25876307212, 3369.7641165118207, 3371.494275858641, 5681.659100453986, 5790.276215473066, 5826.951148793173, 5827.825165245049, 5885.146653735184, 6410.61536307823, 6440.323766004502, 6447.774327898501, 6472.320406357265, 6478.319776423502, 5871.089981052944, 5883.735231914659, 5885.529157667376, 5886.646801191942, 5886.676232807151, 6163.845903852261, 6279.466245369194, 6280.434760871543, 6288.182536270256, 6293.622382657055, 6104.755809767559, 6110.7555697771595, 6120.234970628671, 6121.387861213843, 6133.4786543142545, 5841.853953651193, 5846.0, 5882.058870580687, 5886.381929897299, 5892.823215303548, 4152.584741525823, 4203.789810509524, 4206.8737937861915, 4236.978815105905, 4252.978735106429, 6064.605800622945, 6265.624062556261, 6282.371762823681, 6290.465310448663, 6290.99344104941, 6032.969835150796, 6036.396360363929, 6041.2750469943885, 6042.607230530001, 6044.9395506044375, 6014.609050411709, 6039.063945088518, 6041.063635136561, 6042.818715438544, 6044.697765111639, 5696.1455781633085, 5892.94107058924, 5896.3514013457625, 5900.675462849585, 5901.878643057806, 6044.9395506044375, 6046.032634778414, 6049.969750151221, 6065.181200538047, 6082.239720034996, 5932.703364831655, 5939.0, 5943.940560594512, 5944.881102377842, 5952.226210592596], "unit": "ms", "name": "prototype.html", "value": 4464.60659975044}, {"lowerIsBetter": false, "replicates": [716.4733920568378, 775.3874439193038, 777.8094366880114, 790.9327707144893, 800.8238187598728, 12113.878861211386, 12244.632661020183, 12279.877201227984, 12283.754324913496, 12285.0, 10964.616238431656, 11555.133364997617, 11795.351255680935, 11799.646010619696, 13013.349332533382, 806.701520437439, 820.2945466898462, 821.4660470694037, 821.8438496685641, 823.5799742131526, 809.6599428240124, 814.1126172472004, 815.8653822119343, 815.8857759913587, 816.4162623724036, 842.0695131879277, 844.543946269014, 845.5814371885895, 846.174979395091, 848.1094850407079, 835.0563862834957, 837.0541288344193, 839.7270886961762, 840.9537475438848, 841.869510225916, 616.9845753856144, 620.7641096383345, 621.316551793024, 624.3506752976898, 625.327772644409, 10244.436555989418, 10339.431331276777, 10339.844902326471, 10360.171186305153, 10376.221783366278, 11386.0, 11402.429878506042, 11506.827397589042, 11571.479283432265, 11585.536578536932, 9191.126842949909, 9240.907590924138, 9318.86021709675, 9320.161185493338, 9321.580528876217, 3197.392495425885, 3263.3147039121814, 3270.967290327114, 3286.211309285778, 3340.048086295394, 37508.249835003146, 38579.421308680394, 38721.806390968144, 38730.6126938727, 38964.22071558581, 9044.592993315317, 9156.26749860023, 9273.119053690023, 9319.534023298807, 9502.0, 15632.4528641497, 15717.135557544216, 15774.290156942965, 15788.447404340794, 15789.763153552705, 6014.909776353271, 6253.843653908598, 6538.574992625464, 6657.700403481758, 6662.933370666328, 3456.75802693809, 3623.2753449310244, 3653.159773252167, 3705.1107734144152, 3709.9443508347395, 2727.0, 2728.6998430172666, 2757.696653368128, 2758.1863350311705, 2760.682521510012, 482.156226603444, 488.53833127694696, 488.6091127098307, 492.820120655958, 512.180511182113, 464.8675127588621, 608.9878202435926, 622.163190508774, 629.9370062993664, 634.1217413881807, 7613.961930190424, 7644.847103057908, 7652.885206721904, 7754.9224507755325, 7769.6115194240065, 569.0922977850322, 574.0642752313702, 594.9167116603679, 603.2971588099903, 627.576385939489, 3609.6931760800626, 3712.201876596545, 3729.9254014920093, 3801.885943421702, 3807.143392736612, 47772.28341574879, 48373.75813120982, 48412.27381589279, 48590.0, 48620.27069593959, 42536.361954570704, 42579.57420425756, 43836.561634383244, 44065.0, 44456.0, 39943.40084898729, 41226.38160427596, 43495.34756978648, 43762.12475750467, 43913.34129988053, 8185.508869467851, 8202.630881610223, 8325.875111873205, 8397.874031889405, 8506.404551681322, 31943.840280799377, 32077.35845283128, 32089.518657219694, 32131.518027229144, 32505.67494325121, 37010.25979480449, 38635.806820965714, 38833.611663883, 39123.608763911994, 39304.60695393124, 10211.795764084825, 10321.174306055347, 10388.584456621953, 10619.787604248026, 10837.349759014485, 10460.63387781424, 10667.946660266649, 11333.943330283295, 11351.659450216506, 12200.877991219973, 10671.89328106709, 10760.192985526273, 10790.298630588986, 10836.512356943798, 11223.66329010131, 10105.848412273968, 10611.257211995086, 10697.839532406864, 10745.785084298426, 11045.28205666629, 10588.682339529827, 10626.893731062899, 10639.946800265949, 10687.946560267459, 10891.509882055168, 8889.955550222467, 9279.72160835176, 9469.905300947177, 9508.429494230368, 9618.0, 8532.146785321418, 8821.117888211127, 8867.556622168737, 8939.508327041814, 8947.619805763487], "unit": "ms", "name": "yui.html", "value": 5758.9110532881505}], "name": "dromaeo_css", "value": 6471.920145994728}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 109.0, 113.0, 113.0, 113.0, 125.0, 114.0, 113.0, 111.0, 113.0], "unit": "ms", "name": "ai-astar", "value": 113.6}, {"lowerIsBetter": true, "replicates": [163.0, 135.0, 154.0, 166.0, 131.0, 160.0, 162.0, 138.0, 174.0, 137.0], "unit": "ms", "name": "audio-beat-detection", "value": 152.0}, {"lowerIsBetter": true, "replicates": [163.0, 163.0, 162.0, 160.0, 162.0, 164.0, 172.0, 164.0, 164.0, 164.0], "unit": "ms", "name": "audio-dft", "value": 163.8}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 73.0, 72.0, 73.0, 128.0, 74.0, 78.0, 72.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 78.6}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 132.0, 94.0, 94.0, 94.0, 138.0, 96.0, 95.0, 127.0], "unit": "ms", "name": "audio-oscillator", "value": 105.9}, {"lowerIsBetter": true, "replicates": [113.0, 110.0, 110.0, 110.0, 110.0, 111.0, 111.0, 110.0, 111.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.6}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 148.0, 147.0, 148.0, 147.0, 148.0, 147.0, 147.0, 148.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 98.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [74.0, 75.0, 73.0, 72.0, 72.0, 73.0, 73.0, 75.0, 72.0, 72.0], "unit": "ms", "name": "json-parse-financial", "value": 73.1}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 69.0, 68.0, 69.0, 69.0, 69.0, 68.0, 68.0, 67.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 84.0, 87.0, 84.0, 93.0, 84.0, 86.0, 85.0, 87.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.9}, {"lowerIsBetter": true, "replicates": [131.0, 127.0, 123.0, 126.0, 120.0, 124.0, 150.0, 129.0, 141.0, 130.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 130.1}, {"lowerIsBetter": true, "replicates": [140.0, 149.0, 149.0, 151.0, 154.0, 155.0, 151.0, 144.0, 148.0, 137.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 147.8}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 70.0, 71.0, 71.0, 70.0, 71.0, 69.0, 71.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 70.8}], "name": "kraken", "value": 1544.1999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.11229946524065], "unit": "score", "name": "Richards", "value": 211.24716800000004}, {"lowerIsBetter": false, "replicates": [185.1851851851852], "unit": "score", "name": "DeltaBlue", "value": 357.03720000000015}, {"lowerIsBetter": false, "replicates": [277.623542476402], "unit": "score", "name": "Encrypt", "value": 958.7839620000002}, {"lowerIsBetter": false, "replicates": [5175.257731958763], "unit": "score", "name": "Decrypt", "value": 51.433380478087685}, {"lowerIsBetter": false, "replicates": [1048.1675392670156], "unit": "score", "name": "RayTrace", "value": 705.9835114885117}, {"lowerIsBetter": false, "replicates": [723.589001447178], "unit": "score", "name": "Earley", "value": 921.051866}, {"lowerIsBetter": false, "replicates": [12231.707317073171], "unit": "score", "name": "Boyer", "value": 54.4865064805583}, {"lowerIsBetter": false, "replicates": [26051.28205128205], "unit": "score", "name": "RegExp", "value": 34.96891240157479}, {"lowerIsBetter": false, "replicates": [597.3715651135007], "unit": "score", "name": "Splay", "value": 136.41593400000002}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 21394.38817883779}]} 13:53:31 INFO - RETURN: dromaeo_css: 6471.92 13:53:31 INFO - RETURN: kraken: 1544.20 13:53:31 INFO - RETURN: v8_7: 21394.39 13:53:31 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,43]]", "result": "21394.39"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,43]]", "result": "1544.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,43]]", "result": "6471.92"}}} 13:53:31 INFO - Return code: 0 13:53:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:53:31 INFO - # TBPL SUCCESS # 13:53:31 INFO - Running post-action listener: _resource_record_post_action 13:53:31 INFO - Running post-run listener: _resource_record_post_run 13:53:32 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 4096; Write bytes: 514576384; Read time: 8; Write time: 546660 13:53:32 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 239861760; Read time: 0; Write time: 371628 13:53:32 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 4096; Write bytes: 270659584; Read time: 8; Write time: 174044 13:53:32 INFO - Running post-run listener: _upload_blobber_files 13:53:32 INFO - Blob upload gear active. 13:53:32 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 13:53:32 INFO - Copying logs to upload dir... 13:53:32 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1265.552240 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2015-12-14 13:53:32.487498) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-14 13:53:32.490844) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/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/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8e92d6ac3b8b0dffa3775d33000001f9-1450128745.803361-117896578 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010002 build_url: 'https://queue.taskcluster.net/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-14 13:53:32.541587) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 13:53:32.541911) ========= rm -f oauth.txt in dir /builds/slave/test/. (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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8e92d6ac3b8b0dffa3775d33000001f9-1450128745.803361-117896578 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004492 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 13:53:32.590870) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-14 13:53:32.591155) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-14 13:53:32.591453) ========= ========= Total master_lag: 0.22 =========