builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-047 starttime: 1448624017.28 results: success (0) buildid: 20151127020911 builduid: 2bbe6a23ee50471eba54bac2d6a6ddb6 revision: 47b49b0d32360fab04b11ff9120970979c426911 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-27 03:33:37.282891) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-27 03:33:37.283350) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-27 03:33:37.283864) ========= 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=f5f5a079460e1a9be8676904000001c1-1448623641.758232-1609909953 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006584 basedir: '/builds/slave/test' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-27 03:33:37.351941) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-27 03:33:37.352245) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-27 03:33:37.424159) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 03:33:37.424520) ========= 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=f5f5a079460e1a9be8676904000001c1-1448623641.758232-1609909953 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004721 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 03:33:37.475105) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-27 03:33:37.475440) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-27 03:33:37.475834) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 03:33:37.476134) ========= 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=f5f5a079460e1a9be8676904000001c1-1448623641.758232-1609909953 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-27 03:33:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2015-11-27 03:33:37 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.187638 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 03:33:37.675935) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 03:33:37.676326) ========= 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=f5f5a079460e1a9be8676904000001c1-1448623641.758232-1609909953 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016854 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 03:33:37.727115) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 03:33:37.727496) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 47b49b0d32360fab04b11ff9120970979c426911 --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 47b49b0d32360fab04b11ff9120970979c426911 --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=f5f5a079460e1a9be8676904000001c1-1448623641.758232-1609909953 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-27 03:33:38,004 truncating revision to first 12 chars 2015-11-27 03:33:38,004 Setting DEBUG logging. 2015-11-27 03:33:38,004 attempt 1/10 2015-11-27 03:33:38,004 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/47b49b0d3236?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-27 03:33:38,270 unpacking tar archive at: mozilla-central-47b49b0d3236/testing/mozharness/ program finished with exit code 0 elapsedTime=0.540449 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 03:33:38.281430) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-27 03:33:38.281742) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-27 03:33:38.299997) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-27 03:33:38.300267) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-27 03:33:38.300676) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2015-11-27 03:33:38.301007) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=f5f5a079460e1a9be8676904000001c1-1448623641.758232-1609909953 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:33:38 INFO - MultiFileLogger online at 20151127 03:33:38 in /builds/slave/test 03:33:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 03:33:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:33:38 INFO - {'append_to_log': False, 03:33:38 INFO - 'base_work_dir': '/builds/slave/test', 03:33:38 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:33:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:33:38 INFO - 'branch': 'Firefox-Non-PGO', 03:33:38 INFO - 'buildbot_json_path': 'buildprops.json', 03:33:38 INFO - 'config_files': ('talos/linux_config.py',), 03:33:38 INFO - 'default_actions': ('clobber', 03:33:38 INFO - 'read-buildbot-config', 03:33:38 INFO - 'download-and-extract', 03:33:38 INFO - 'populate-webroot', 03:33:38 INFO - 'create-virtualenv', 03:33:38 INFO - 'install', 03:33:38 INFO - 'run-tests'), 03:33:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:33:38 INFO - 'download_minidump_stackwalk': True, 03:33:38 INFO - 'download_symbols': 'ondemand', 03:33:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:33:38 INFO - 'tooltool.py': '/tools/tooltool.py', 03:33:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:33:38 INFO - '/tools/misc-python/virtualenv.py')}, 03:33:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:33:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:33:38 INFO - 'installer_path': 'installer.exe', 03:33:38 INFO - 'log_level': 'info', 03:33:38 INFO - 'log_name': 'talos', 03:33:38 INFO - 'log_to_console': True, 03:33:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:33:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:33:38 INFO - 'opt_config_files': (), 03:33:38 INFO - 'pip_index': False, 03:33:38 INFO - 'sps_profile': False, 03:33:38 INFO - 'sps_profile_interval': 0, 03:33:38 INFO - 'suite': 'dromaeojs', 03:33:38 INFO - 'system_bits': '64', 03:33:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:33:38 INFO - 'title': 'talos-linux64-ix-047', 03:33:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:33:38 INFO - 'use_talos_json': True, 03:33:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:33:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:33:38 INFO - 'work_dir': 'build'} 03:33:38 INFO - ##### 03:33:38 INFO - ##### Running clobber step. 03:33:38 INFO - ##### 03:33:38 INFO - Running pre-action listener: _resource_record_pre_action 03:33:38 INFO - Running main action method: clobber 03:33:38 INFO - rmtree: /builds/slave/test/build 03:33:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:33:39 INFO - Running post-action listener: _resource_record_post_action 03:33:39 INFO - ##### 03:33:39 INFO - ##### Running read-buildbot-config step. 03:33:39 INFO - ##### 03:33:39 INFO - Running pre-action listener: _resource_record_pre_action 03:33:39 INFO - Running main action method: read_buildbot_config 03:33:39 INFO - Using buildbot properties: 03:33:39 INFO - { 03:33:39 INFO - "properties": { 03:33:39 INFO - "buildnumber": 334, 03:33:39 INFO - "product": "firefox", 03:33:39 INFO - "script_repo_revision": "production", 03:33:39 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 03:33:39 INFO - "repository": "", 03:33:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 03:33:39 INFO - "buildid": "20151127020911", 03:33:39 INFO - "slavename": "talos-linux64-ix-047", 03:33:39 INFO - "pgo_build": "False", 03:33:39 INFO - "basedir": "/builds/slave/test", 03:33:39 INFO - "project": "", 03:33:39 INFO - "platform": "ubuntu64_hw", 03:33:39 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:33:39 INFO - "slavebuilddir": "test", 03:33:39 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 03:33:39 INFO - "branch": "mozilla-central", 03:33:39 INFO - "repo_path": "mozilla-central", 03:33:39 INFO - "stage_platform": "linux64", 03:33:39 INFO - "builduid": "2bbe6a23ee50471eba54bac2d6a6ddb6", 03:33:39 INFO - "revision": "47b49b0d32360fab04b11ff9120970979c426911" 03:33:39 INFO - }, 03:33:39 INFO - "sourcestamp": { 03:33:39 INFO - "repository": "", 03:33:39 INFO - "hasPatch": false, 03:33:39 INFO - "project": "", 03:33:39 INFO - "branch": "mozilla-central-linux64-talos", 03:33:39 INFO - "changes": [ 03:33:39 INFO - { 03:33:39 INFO - "category": null, 03:33:39 INFO - "files": [ 03:33:39 INFO - { 03:33:39 INFO - "url": null, 03:33:39 INFO - "name": "https://queue.taskcluster.net/v1/task/XzM3swrvSAeNyTVpz58pgw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 03:33:39 INFO - } 03:33:39 INFO - ], 03:33:39 INFO - "repository": "", 03:33:39 INFO - "rev": "47b49b0d32360fab04b11ff9120970979c426911", 03:33:39 INFO - "who": "cbook@mozilla.com", 03:33:39 INFO - "when": 1448623960, 03:33:39 INFO - "number": 6714475, 03:33:39 INFO - "comments": "merge mozilla-inbound to mozilla-central a=merge", 03:33:39 INFO - "project": "", 03:33:39 INFO - "at": "Fri 27 Nov 2015 03:32:40", 03:33:39 INFO - "branch": "mozilla-central-linux64-talos", 03:33:39 INFO - "revlink": "", 03:33:39 INFO - "properties": [ 03:33:39 INFO - [ 03:33:39 INFO - "buildid", 03:33:39 INFO - "20151127020911", 03:33:39 INFO - "Change" 03:33:39 INFO - ], 03:33:39 INFO - [ 03:33:39 INFO - "builduid", 03:33:39 INFO - "2bbe6a23ee50471eba54bac2d6a6ddb6", 03:33:39 INFO - "Change" 03:33:39 INFO - ], 03:33:39 INFO - [ 03:33:39 INFO - "pgo_build", 03:33:39 INFO - "False", 03:33:39 INFO - "Change" 03:33:39 INFO - ] 03:33:39 INFO - ], 03:33:39 INFO - "revision": "47b49b0d32360fab04b11ff9120970979c426911" 03:33:39 INFO - } 03:33:39 INFO - ], 03:33:39 INFO - "revision": "47b49b0d32360fab04b11ff9120970979c426911" 03:33:39 INFO - } 03:33:39 INFO - } 03:33:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/XzM3swrvSAeNyTVpz58pgw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 03:33:39 INFO - Running post-action listener: _resource_record_post_action 03:33:39 INFO - ##### 03:33:39 INFO - ##### Running download-and-extract step. 03:33:39 INFO - ##### 03:33:39 INFO - Running pre-action listener: _resource_record_pre_action 03:33:39 INFO - Running main action method: download_and_extract 03:33:39 INFO - mkdir: /builds/slave/test/build/tests 03:33:39 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')]} 03:33:39 INFO - https://queue.taskcluster.net/v1/task/XzM3swrvSAeNyTVpz58pgw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:33:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XzM3swrvSAeNyTVpz58pgw/artifacts/public/build/test_packages.json 03:33:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XzM3swrvSAeNyTVpz58pgw/artifacts/public/build/test_packages.json 03:33:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XzM3swrvSAeNyTVpz58pgw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 03:33:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XzM3swrvSAeNyTVpz58pgw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 03:33:39 INFO - Downloaded 1302 bytes. 03:33:39 INFO - Reading from file /builds/slave/test/build/test_packages.json 03:33:39 INFO - Using the following test package requirements: 03:33:39 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 03:33:39 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:33:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:33:39 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:33:39 INFO - u'jsshell-linux-x86_64.zip'], 03:33:39 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:33:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:33:39 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 03:33:39 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:33:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:33:39 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:33:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:33:39 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:33:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:33:39 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 03:33:39 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:33:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:33:39 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:33:39 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')]} 03:33:39 INFO - https://queue.taskcluster.net/v1/task/XzM3swrvSAeNyTVpz58pgw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:33:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XzM3swrvSAeNyTVpz58pgw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:33:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XzM3swrvSAeNyTVpz58pgw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:33:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XzM3swrvSAeNyTVpz58pgw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:33:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XzM3swrvSAeNyTVpz58pgw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:33:41 INFO - Downloaded 21516951 bytes. 03:33:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 03:33:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:33:41 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 03:33:42 INFO - Return code: 0 03:33:42 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:33:42 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')]} 03:33:42 INFO - https://queue.taskcluster.net/v1/task/XzM3swrvSAeNyTVpz58pgw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:33:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XzM3swrvSAeNyTVpz58pgw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:33:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XzM3swrvSAeNyTVpz58pgw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:33:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XzM3swrvSAeNyTVpz58pgw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:33:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XzM3swrvSAeNyTVpz58pgw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:33:47 INFO - Downloaded 21516951 bytes. 03:33:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 03:33:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:33:47 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 03:33:49 INFO - Return code: 0 03:33: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')]} 03:33:49 INFO - https://queue.taskcluster.net/v1/task/XzM3swrvSAeNyTVpz58pgw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:33:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XzM3swrvSAeNyTVpz58pgw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:33:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XzM3swrvSAeNyTVpz58pgw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:33:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XzM3swrvSAeNyTVpz58pgw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:33:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XzM3swrvSAeNyTVpz58pgw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:33:50 INFO - Downloaded 11131728 bytes. 03:33:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 03:33:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:33:50 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 03:33:50 INFO - Return code: 0 03:33:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:50 INFO - https://queue.taskcluster.net/v1/task/XzM3swrvSAeNyTVpz58pgw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:33:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XzM3swrvSAeNyTVpz58pgw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:33:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XzM3swrvSAeNyTVpz58pgw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:33:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XzM3swrvSAeNyTVpz58pgw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:33:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XzM3swrvSAeNyTVpz58pgw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:33:51 INFO - Downloaded 56873843 bytes. 03:33:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XzM3swrvSAeNyTVpz58pgw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:33:51 INFO - mkdir: /builds/slave/test/properties 03:33:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:33:51 INFO - Writing to file /builds/slave/test/properties/build_url 03:33:51 INFO - Contents: 03:33:51 INFO - build_url:https://queue.taskcluster.net/v1/task/XzM3swrvSAeNyTVpz58pgw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:33:51 INFO - Running post-action listener: _resource_record_post_action 03:33:51 INFO - Running post-action listener: set_extra_try_arguments 03:33:51 INFO - ##### 03:33:51 INFO - ##### Running populate-webroot step. 03:33:51 INFO - ##### 03:33:51 INFO - Running pre-action listener: _resource_record_pre_action 03:33:51 INFO - Running main action method: populate_webroot 03:33:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:33:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:33:51 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 03:33:51 INFO - '../fennec_ids.txt'], 03:33:51 INFO - 'tests': ['tcheck2']}, 03:33:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:33:51 INFO - '--tppagecycles', 03:33:51 INFO - '7'], 03:33:51 INFO - 'tests': ['tsvgm']}}, 03:33:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:33:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:33:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:33:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:33:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:33:51 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:33:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:33:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:51 INFO - 'talos_options': ['--e10s'], 03:33:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:33:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:51 INFO - 'tests': ['damp', 'tps']}, 03:33:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:51 INFO - 'talos_options': ['--e10s'], 03:33:51 INFO - 'tests': ['damp', 'tps']}, 03:33:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:33:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:33:51 INFO - 'other': {'tests': ['a11yr', 03:33:51 INFO - 'ts_paint', 03:33:51 INFO - 'tpaint', 03:33:51 INFO - 'sessionrestore', 03:33:51 INFO - 'sessionrestore_no_auto_restore']}, 03:33:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:33:51 INFO - 'tests': ['a11yr', 03:33:51 INFO - 'ts_paint', 03:33:51 INFO - 'tpaint', 03:33:51 INFO - 'sessionrestore', 03:33:51 INFO - 'sessionrestore_no_auto_restore']}, 03:33:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:33:51 INFO - 'tests': ['a11yr', 03:33:51 INFO - 'ts_paint', 03:33:51 INFO - 'tpaint', 03:33:51 INFO - 'sessionrestore', 03:33:51 INFO - 'sessionrestore_no_auto_restore']}, 03:33:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:33:51 INFO - 'tests': ['a11yr', 03:33:51 INFO - 'ts_paint', 03:33:51 INFO - 'tpaint', 03:33:51 INFO - 'sessionrestore', 03:33:51 INFO - 'sessionrestore_no_auto_restore']}, 03:33:51 INFO - 'other_l64': {'tests': ['a11yr', 03:33:51 INFO - 'ts_paint', 03:33:51 INFO - 'tpaint', 03:33:51 INFO - 'sessionrestore', 03:33:51 INFO - 'sessionrestore_no_auto_restore']}, 03:33:51 INFO - 'other_nol64': {'tests': ['a11yr', 03:33:51 INFO - 'ts_paint', 03:33:51 INFO - 'tpaint', 03:33:51 INFO - 'sessionrestore', 03:33:51 INFO - 'sessionrestore_no_auto_restore']}, 03:33:51 INFO - 'svgr': {'tests': ['tsvgx', 03:33:51 INFO - 'tsvgr_opacity', 03:33:51 INFO - 'tart', 03:33:51 INFO - 'tscrollx', 03:33:51 INFO - 'cart']}, 03:33:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:33:51 INFO - 'tests': ['tsvgx', 03:33:51 INFO - 'tsvgr_opacity', 03:33:51 INFO - 'tart', 03:33:51 INFO - 'tscrollx', 03:33:51 INFO - 'cart']}, 03:33:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:51 INFO - 'tests': ['tp5o']}, 03:33:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:51 INFO - 'talos_options': ['--e10s'], 03:33:51 INFO - 'tests': ['tp5o']}, 03:33:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:51 INFO - 'talos_options': ['--xperf_path', 03:33:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:33:51 INFO - 'tests': ['tp5n']}, 03:33:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:51 INFO - 'talos_options': ['--e10s', 03:33:51 INFO - '--xperf_path', 03:33:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:33:51 INFO - 'tests': ['tp5n']}}, 03:33:51 INFO - 'talos.zip': {'path': '', 03:33:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:33:51 INFO - Running post-action listener: _resource_record_post_action 03:33:51 INFO - ##### 03:33:51 INFO - ##### Running create-virtualenv step. 03:33:51 INFO - ##### 03:33:51 INFO - Running pre-action listener: _resource_record_pre_action 03:33:51 INFO - Running main action method: create_virtualenv 03:33:51 INFO - Creating virtualenv /builds/slave/test/build/venv 03:33:51 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 03:33:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:33:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:33:51 INFO - Using real prefix '/usr' 03:33:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:33:52 INFO - Installing distribute.............................................................................................................................................................................................done. 03:33:54 INFO - Installing pip.................done. 03:33:54 INFO - Return code: 0 03:33:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:33:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:54 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 0x7f76c3994f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1660240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ef0b0>, '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 0x16effb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f0440>, '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': 'f5f5a079460e1a9be8676904000001c1-1448623641.758232-1609909953', '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 03:33:54 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 03:33:54 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 03:33:54 INFO - Using env: {'DISPLAY': ':0', 03:33:54 INFO - 'HOME': '/home/cltbld', 03:33:54 INFO - 'LANG': 'en_US.UTF-8', 03:33:54 INFO - 'LANGUAGE': 'en_US:en', 03:33:54 INFO - 'LOGNAME': 'cltbld', 03:33:54 INFO - 'MAIL': '/var/mail/cltbld', 03:33:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:54 INFO - 'MOZ_NO_REMOTE': '1', 03:33:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:54 INFO - 'NO_EM_RESTART': '1', 03:33:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:54 INFO - 'PWD': '/builds/slave/test', 03:33:54 INFO - 'SHELL': '/bin/bash', 03:33:54 INFO - 'SHLVL': '1', 03:33:54 INFO - 'TERM': 'linux', 03:33:54 INFO - 'TMOUT': '86400', 03:33:54 INFO - 'USER': 'cltbld', 03:33:54 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1448623641.758232-1609909953', 03:33:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:54 INFO - '_': '/tools/buildbot/bin/python'} 03:33:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:54 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 03:33:54 INFO - Cleaning up... 03:33:54 INFO - Return code: 0 03:33:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:33:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:54 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 0x7f76c3994f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1660240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ef0b0>, '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 0x16effb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f0440>, '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': 'f5f5a079460e1a9be8676904000001c1-1448623641.758232-1609909953', '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 03:33:54 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 03:33:54 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 03:33:54 INFO - Using env: {'DISPLAY': ':0', 03:33:54 INFO - 'HOME': '/home/cltbld', 03:33:54 INFO - 'LANG': 'en_US.UTF-8', 03:33:54 INFO - 'LANGUAGE': 'en_US:en', 03:33:54 INFO - 'LOGNAME': 'cltbld', 03:33:54 INFO - 'MAIL': '/var/mail/cltbld', 03:33:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:54 INFO - 'MOZ_NO_REMOTE': '1', 03:33:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:54 INFO - 'NO_EM_RESTART': '1', 03:33:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:54 INFO - 'PWD': '/builds/slave/test', 03:33:54 INFO - 'SHELL': '/bin/bash', 03:33:54 INFO - 'SHLVL': '1', 03:33:54 INFO - 'TERM': 'linux', 03:33:54 INFO - 'TMOUT': '86400', 03:33:54 INFO - 'USER': 'cltbld', 03:33:54 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1448623641.758232-1609909953', 03:33:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:54 INFO - '_': '/tools/buildbot/bin/python'} 03:33:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:54 INFO - Downloading/unpacking psutil>=0.7.1 03:33:54 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 03:33:54 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 03:33:54 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 03:33:54 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 03:33:54 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 03:33:54 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 03:33:56 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 03:33:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 03:33:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:33:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:33:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:33:56 INFO - Installing collected packages: psutil 03:33:56 INFO - Running setup.py install for psutil 03:33:56 INFO - building 'psutil._psutil_linux' extension 03:33:56 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 03:33:56 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 03:33:56 INFO - building 'psutil._psutil_posix' extension 03:33:56 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 03:33:56 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 03:33:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:33:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:33:56 INFO - Successfully installed psutil 03:33:56 INFO - Cleaning up... 03:33:57 INFO - Return code: 0 03:33:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:33:57 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')]} 03:33:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:57 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')]} 03:33:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:57 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 0x7f76c3994f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1660240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ef0b0>, '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 0x16effb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f0440>, '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': 'f5f5a079460e1a9be8676904000001c1-1448623641.758232-1609909953', '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 03:33:57 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 03:33:57 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 03:33:57 INFO - Using env: {'DISPLAY': ':0', 03:33:57 INFO - 'HOME': '/home/cltbld', 03:33:57 INFO - 'LANG': 'en_US.UTF-8', 03:33:57 INFO - 'LANGUAGE': 'en_US:en', 03:33:57 INFO - 'LOGNAME': 'cltbld', 03:33:57 INFO - 'MAIL': '/var/mail/cltbld', 03:33:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:57 INFO - 'MOZ_NO_REMOTE': '1', 03:33:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:57 INFO - 'NO_EM_RESTART': '1', 03:33:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:57 INFO - 'PWD': '/builds/slave/test', 03:33:57 INFO - 'SHELL': '/bin/bash', 03:33:57 INFO - 'SHLVL': '1', 03:33:57 INFO - 'TERM': 'linux', 03:33:57 INFO - 'TMOUT': '86400', 03:33:57 INFO - 'USER': 'cltbld', 03:33:57 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1448623641.758232-1609909953', 03:33:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:57 INFO - '_': '/tools/buildbot/bin/python'} 03:33:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:33: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 03:33: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 03:33: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 03:33: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 03:33: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 03:33: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 03:33:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:33:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 03:33:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:33:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:33:58 INFO - Installing collected packages: mozsystemmonitor 03:33:58 INFO - Running setup.py install for mozsystemmonitor 03:33:59 INFO - Successfully installed mozsystemmonitor 03:33:59 INFO - Cleaning up... 03:33:59 INFO - Return code: 0 03:33:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:33:59 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')]} 03:33:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:59 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')]} 03:33:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:59 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 0x7f76c3994f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1660240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ef0b0>, '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 0x16effb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f0440>, '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': 'f5f5a079460e1a9be8676904000001c1-1448623641.758232-1609909953', '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 03:33:59 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 03:33:59 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 03:33:59 INFO - Using env: {'DISPLAY': ':0', 03:33:59 INFO - 'HOME': '/home/cltbld', 03:33:59 INFO - 'LANG': 'en_US.UTF-8', 03:33:59 INFO - 'LANGUAGE': 'en_US:en', 03:33:59 INFO - 'LOGNAME': 'cltbld', 03:33:59 INFO - 'MAIL': '/var/mail/cltbld', 03:33:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:59 INFO - 'MOZ_NO_REMOTE': '1', 03:33:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:59 INFO - 'NO_EM_RESTART': '1', 03:33:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:59 INFO - 'PWD': '/builds/slave/test', 03:33:59 INFO - 'SHELL': '/bin/bash', 03:33:59 INFO - 'SHLVL': '1', 03:33:59 INFO - 'TERM': 'linux', 03:33:59 INFO - 'TMOUT': '86400', 03:33:59 INFO - 'USER': 'cltbld', 03:33:59 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1448623641.758232-1609909953', 03:33:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:59 INFO - '_': '/tools/buildbot/bin/python'} 03:33:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:59 INFO - Downloading/unpacking blobuploader==1.2.4 03:33:59 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 03:33:59 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 03:33:59 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 03:33:59 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 03:33:59 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 03:33:59 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 03:34:01 INFO - Downloading blobuploader-1.2.4.tar.gz 03:34:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 03:34:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:34:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:34:01 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 03:34:01 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 03:34:01 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 03:34:01 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 03:34:01 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 03:34:01 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 03:34:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 03:34:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:34:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:34:01 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 03:34:01 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 03:34:01 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 03:34:01 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 03:34:01 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 03:34:01 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 03:34:01 INFO - Downloading docopt-0.6.1.tar.gz 03:34:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 03:34:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:34:01 INFO - Installing collected packages: blobuploader, requests, docopt 03:34:01 INFO - Running setup.py install for blobuploader 03:34:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:34:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:34:01 INFO - Running setup.py install for requests 03:34:02 INFO - Running setup.py install for docopt 03:34:02 INFO - Successfully installed blobuploader requests docopt 03:34:02 INFO - Cleaning up... 03:34:02 INFO - Return code: 0 03:34:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:34:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:02 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 0x7f76c3994f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1660240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ef0b0>, '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 0x16effb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f0440>, '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': 'f5f5a079460e1a9be8676904000001c1-1448623641.758232-1609909953', '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 03:34:02 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 03:34:02 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 03:34:02 INFO - Using env: {'DISPLAY': ':0', 03:34:02 INFO - 'HOME': '/home/cltbld', 03:34:02 INFO - 'LANG': 'en_US.UTF-8', 03:34:02 INFO - 'LANGUAGE': 'en_US:en', 03:34:02 INFO - 'LOGNAME': 'cltbld', 03:34:02 INFO - 'MAIL': '/var/mail/cltbld', 03:34:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:02 INFO - 'MOZ_NO_REMOTE': '1', 03:34:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:02 INFO - 'NO_EM_RESTART': '1', 03:34:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:02 INFO - 'PWD': '/builds/slave/test', 03:34:02 INFO - 'SHELL': '/bin/bash', 03:34:02 INFO - 'SHLVL': '1', 03:34:02 INFO - 'TERM': 'linux', 03:34:02 INFO - 'TMOUT': '86400', 03:34:02 INFO - 'USER': 'cltbld', 03:34:02 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1448623641.758232-1609909953', 03:34:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:02 INFO - '_': '/tools/buildbot/bin/python'} 03:34:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:34:02 INFO - Running setup.py (path:/tmp/pip-_OQL4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:34:02 INFO - Running setup.py (path:/tmp/pip-6aRJSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:34:02 INFO - Running setup.py (path:/tmp/pip-0_M8x7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:34:02 INFO - Running setup.py (path:/tmp/pip-houC2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:34:02 INFO - Running setup.py (path:/tmp/pip-sbZJE4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:34:02 INFO - Running setup.py (path:/tmp/pip-ZFdJuY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:34:03 INFO - Running setup.py (path:/tmp/pip-eDfpgG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:34:03 INFO - Running setup.py (path:/tmp/pip-CmzCzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:34:03 INFO - Running setup.py (path:/tmp/pip-JkTjsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:34:03 INFO - Running setup.py (path:/tmp/pip-DyxXxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:34:03 INFO - Running setup.py (path:/tmp/pip-FDwft2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:34:03 INFO - Running setup.py (path:/tmp/pip-vNu4D9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:34:03 INFO - Running setup.py (path:/tmp/pip-sqDlBt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:34:03 INFO - Running setup.py (path:/tmp/pip-RLjqnk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:34:03 INFO - Running setup.py (path:/tmp/pip-XiIkcc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:34:03 INFO - Running setup.py (path:/tmp/pip-4fRVSQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:34:03 INFO - Running setup.py (path:/tmp/pip-cz9PL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:34:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:34:03 INFO - Running setup.py install for manifestparser 03:34:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:34:03 INFO - Running setup.py install for mozcrash 03:34:03 INFO - Running setup.py install for mozdebug 03:34:04 INFO - Running setup.py install for mozdevice 03:34:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:34:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:34:04 INFO - Running setup.py install for mozfile 03:34:04 INFO - Running setup.py install for mozhttpd 03:34:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:34:04 INFO - Running setup.py install for mozinfo 03:34:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:34:04 INFO - Running setup.py install for mozInstall 03:34:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:34:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:34:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:34:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:34:04 INFO - Running setup.py install for mozleak 03:34:04 INFO - Running setup.py install for mozlog 03:34:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:34:04 INFO - Running setup.py install for moznetwork 03:34:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:34:04 INFO - Running setup.py install for mozprocess 03:34:05 INFO - Running setup.py install for mozprofile 03:34:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:34:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:34:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:34:05 INFO - Running setup.py install for mozrunner 03:34:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:34:05 INFO - Running setup.py install for mozscreenshot 03:34:05 INFO - Running setup.py install for moztest 03:34:05 INFO - Running setup.py install for mozversion 03:34:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:34:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:34:05 INFO - Cleaning up... 03:34:05 INFO - Return code: 0 03:34:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:34:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:05 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 0x7f76c3994f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1660240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ef0b0>, '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 0x16effb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f0440>, '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': 'f5f5a079460e1a9be8676904000001c1-1448623641.758232-1609909953', '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 03:34:05 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 03:34:05 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 03:34:05 INFO - Using env: {'DISPLAY': ':0', 03:34:05 INFO - 'HOME': '/home/cltbld', 03:34:05 INFO - 'LANG': 'en_US.UTF-8', 03:34:05 INFO - 'LANGUAGE': 'en_US:en', 03:34:05 INFO - 'LOGNAME': 'cltbld', 03:34:05 INFO - 'MAIL': '/var/mail/cltbld', 03:34:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:05 INFO - 'MOZ_NO_REMOTE': '1', 03:34:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:05 INFO - 'NO_EM_RESTART': '1', 03:34:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:05 INFO - 'PWD': '/builds/slave/test', 03:34:05 INFO - 'SHELL': '/bin/bash', 03:34:05 INFO - 'SHLVL': '1', 03:34:05 INFO - 'TERM': 'linux', 03:34:05 INFO - 'TMOUT': '86400', 03:34:05 INFO - 'USER': 'cltbld', 03:34:05 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1448623641.758232-1609909953', 03:34:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:05 INFO - '_': '/tools/buildbot/bin/python'} 03:34:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:34:05 INFO - Running setup.py (path:/tmp/pip-t5DFz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:34:05 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)) 03:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:34:05 INFO - Running setup.py (path:/tmp/pip-tn5Oen-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:34:05 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)) 03:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:34:05 INFO - Running setup.py (path:/tmp/pip-JOddSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:34:06 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)) 03:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:34:06 INFO - Running setup.py (path:/tmp/pip-3jFICQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:34:06 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)) 03:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:34:06 INFO - Running setup.py (path:/tmp/pip-rkRgCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:34:06 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)) 03:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:34:06 INFO - Running setup.py (path:/tmp/pip-69eX7E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:34:06 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)) 03:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:34:06 INFO - Running setup.py (path:/tmp/pip-jgxHtO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:34:06 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)) 03:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:34:06 INFO - Running setup.py (path:/tmp/pip-SHIzBy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:34:06 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)) 03:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:34:06 INFO - Running setup.py (path:/tmp/pip-Xfeu80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:34:06 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)) 03:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:34:06 INFO - Running setup.py (path:/tmp/pip-fE6NLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:34:06 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)) 03:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:34:06 INFO - Running setup.py (path:/tmp/pip-xPem5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:34:06 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)) 03:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:34:06 INFO - Running setup.py (path:/tmp/pip-3zevWN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:34:06 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)) 03:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:34:06 INFO - Running setup.py (path:/tmp/pip-H0309k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:34:06 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)) 03:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:34:06 INFO - Running setup.py (path:/tmp/pip-byFwQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:34:06 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)) 03:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:34:06 INFO - Running setup.py (path:/tmp/pip-rV0xtc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:34:06 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)) 03:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:34:06 INFO - Running setup.py (path:/tmp/pip-4EQBui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:34:06 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)) 03:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:34:06 INFO - Running setup.py (path:/tmp/pip-BwyOdj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:34:07 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)) 03:34:07 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)) 03:34:07 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)) 03:34:07 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)) 03:34:07 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)) 03:34:07 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)) 03:34:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:34:07 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 03:34:07 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 03:34:07 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 03:34:07 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 03:34:07 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 03:34:07 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 03:34:08 INFO - Downloading blessings-1.5.1.tar.gz 03:34:08 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 03:34:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:34:08 INFO - Installing collected packages: blessings 03:34:08 INFO - Running setup.py install for blessings 03:34:08 INFO - Successfully installed blessings 03:34:08 INFO - Cleaning up... 03:34:08 INFO - Return code: 0 03:34:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:34:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:34:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:34:09 INFO - Reading from file tmpfile_stdout 03:34:09 INFO - Current package versions: 03:34:09 INFO - argparse == 1.2.1 03:34:09 INFO - blessings == 1.5.1 03:34:09 INFO - blobuploader == 1.2.4 03:34:09 INFO - docopt == 0.6.1 03:34:09 INFO - manifestparser == 1.1 03:34:09 INFO - mozInstall == 1.12 03:34:09 INFO - mozcrash == 0.16 03:34:09 INFO - mozdebug == 0.1 03:34:09 INFO - mozdevice == 0.47 03:34:09 INFO - mozfile == 1.2 03:34:09 INFO - mozhttpd == 0.7 03:34:09 INFO - mozinfo == 0.9 03:34:09 INFO - mozleak == 0.1 03:34:09 INFO - mozlog == 3.1 03:34:09 INFO - moznetwork == 0.27 03:34:09 INFO - mozprocess == 0.22 03:34:09 INFO - mozprofile == 0.27 03:34:09 INFO - mozrunner == 6.11 03:34:09 INFO - mozscreenshot == 0.1 03:34:09 INFO - mozsystemmonitor == 0.0 03:34:09 INFO - moztest == 0.7 03:34:09 INFO - mozversion == 1.4 03:34:09 INFO - psutil == 3.1.1 03:34:09 INFO - requests == 1.2.3 03:34:09 INFO - wsgiref == 0.1.2 03:34:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:34:09 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')]} 03:34:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:09 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')]} 03:34:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:09 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 0x7f76c3994f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1660240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ef0b0>, '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 0x16effb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f0440>, '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': 'f5f5a079460e1a9be8676904000001c1-1448623641.758232-1609909953', '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 03:34:09 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 03:34:09 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 03:34:09 INFO - Using env: {'DISPLAY': ':0', 03:34:09 INFO - 'HOME': '/home/cltbld', 03:34:09 INFO - 'LANG': 'en_US.UTF-8', 03:34:09 INFO - 'LANGUAGE': 'en_US:en', 03:34:09 INFO - 'LOGNAME': 'cltbld', 03:34:09 INFO - 'MAIL': '/var/mail/cltbld', 03:34:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:09 INFO - 'MOZ_NO_REMOTE': '1', 03:34:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:09 INFO - 'NO_EM_RESTART': '1', 03:34:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:09 INFO - 'PWD': '/builds/slave/test', 03:34:09 INFO - 'SHELL': '/bin/bash', 03:34:09 INFO - 'SHLVL': '1', 03:34:09 INFO - 'TERM': 'linux', 03:34:09 INFO - 'TMOUT': '86400', 03:34:09 INFO - 'USER': 'cltbld', 03:34:09 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1448623641.758232-1609909953', 03:34:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:09 INFO - '_': '/tools/buildbot/bin/python'} 03:34:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:09 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)) 03:34:09 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)) 03:34:09 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)) 03:34:09 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)) 03:34:09 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)) 03:34:09 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)) 03:34:09 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)) 03:34:09 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)) 03:34:09 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)) 03:34:09 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)) 03:34:09 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)) 03:34:09 INFO - Cleaning up... 03:34:09 INFO - Return code: 0 03:34:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:34:09 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')]} 03:34:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:09 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')]} 03:34:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:09 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 0x7f76c3994f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1660240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ef0b0>, '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 0x16effb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f0440>, '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': 'f5f5a079460e1a9be8676904000001c1-1448623641.758232-1609909953', '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 03:34:09 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 03:34:09 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 03:34:09 INFO - Using env: {'DISPLAY': ':0', 03:34:09 INFO - 'HOME': '/home/cltbld', 03:34:09 INFO - 'LANG': 'en_US.UTF-8', 03:34:09 INFO - 'LANGUAGE': 'en_US:en', 03:34:09 INFO - 'LOGNAME': 'cltbld', 03:34:09 INFO - 'MAIL': '/var/mail/cltbld', 03:34:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:09 INFO - 'MOZ_NO_REMOTE': '1', 03:34:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:09 INFO - 'NO_EM_RESTART': '1', 03:34:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:09 INFO - 'PWD': '/builds/slave/test', 03:34:09 INFO - 'SHELL': '/bin/bash', 03:34:09 INFO - 'SHLVL': '1', 03:34:09 INFO - 'TERM': 'linux', 03:34:09 INFO - 'TMOUT': '86400', 03:34:09 INFO - 'USER': 'cltbld', 03:34:09 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1448623641.758232-1609909953', 03:34:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:09 INFO - '_': '/tools/buildbot/bin/python'} 03:34:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:09 INFO - Downloading/unpacking jsonschema 03:34:09 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 03:34:09 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 03:34:09 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 03:34:09 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 03:34:09 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 03:34:09 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 03:34:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:34:11 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 03:34:11 INFO - Downloading/unpacking functools32 (from jsonschema) 03:34:11 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 03:34:11 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 03:34:11 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 03:34:11 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 03:34:11 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 03:34:11 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 03:34:11 INFO - Downloading functools32-3.2.3-2.tar.gz 03:34:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 03:34:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:34:11 INFO - warning: no files found matching '*.txt' 03:34:11 INFO - no previously-included directories found matching 'build' 03:34:11 INFO - no previously-included directories found matching 'dist' 03:34:11 INFO - no previously-included directories found matching '.git*' 03:34:11 INFO - Installing collected packages: jsonschema, functools32 03:34:11 INFO - Running setup.py install for functools32 03:34:11 INFO - warning: no files found matching '*.txt' 03:34:11 INFO - no previously-included directories found matching 'build' 03:34:11 INFO - no previously-included directories found matching 'dist' 03:34:11 INFO - no previously-included directories found matching '.git*' 03:34:11 INFO - Successfully installed jsonschema functools32 03:34:11 INFO - Cleaning up... 03:34:11 INFO - Return code: 0 03:34:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:34:11 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')]} 03:34:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:11 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')]} 03:34:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:11 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 0x7f76c3994f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1660240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ef0b0>, '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 0x16effb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f0440>, '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': 'f5f5a079460e1a9be8676904000001c1-1448623641.758232-1609909953', '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 03:34:11 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 03:34:11 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 03:34:11 INFO - Using env: {'DISPLAY': ':0', 03:34:11 INFO - 'HOME': '/home/cltbld', 03:34:11 INFO - 'LANG': 'en_US.UTF-8', 03:34:11 INFO - 'LANGUAGE': 'en_US:en', 03:34:11 INFO - 'LOGNAME': 'cltbld', 03:34:11 INFO - 'MAIL': '/var/mail/cltbld', 03:34:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:11 INFO - 'MOZ_NO_REMOTE': '1', 03:34:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:11 INFO - 'NO_EM_RESTART': '1', 03:34:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:11 INFO - 'PWD': '/builds/slave/test', 03:34:11 INFO - 'SHELL': '/bin/bash', 03:34:11 INFO - 'SHLVL': '1', 03:34:11 INFO - 'TERM': 'linux', 03:34:11 INFO - 'TMOUT': '86400', 03:34:11 INFO - 'USER': 'cltbld', 03:34:11 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1448623641.758232-1609909953', 03:34:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:11 INFO - '_': '/tools/buildbot/bin/python'} 03:34:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:11 INFO - Downloading/unpacking flake8 03:34:11 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 03:34:11 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 03:34:11 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 03:34:11 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 03:34:11 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 03:34:11 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 03:34:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:34:13 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 03:34:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:34:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:34:13 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 03:34:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:34:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:13 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 03:34:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:34:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 03:34:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:34:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:34:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:34:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:34:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:34:14 INFO - no previously-included directories found matching 'docs/_build' 03:34:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:34:14 INFO - Running setup.py install for pep8 03:34:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:34:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:34:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:34:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:34:14 INFO - no previously-included directories found matching 'docs/_build' 03:34:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:34:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:34:14 INFO - Cleaning up... 03:34:14 INFO - Return code: 0 03:34:14 INFO - Running post-action listener: _resource_record_post_action 03:34:14 INFO - Running post-action listener: _start_resource_monitoring 03:34:14 INFO - Starting resource monitoring. 03:34:14 INFO - ##### 03:34:14 INFO - ##### Running install step. 03:34:14 INFO - ##### 03:34:14 INFO - Running pre-action listener: _resource_record_pre_action 03:34:14 INFO - Running main action method: install 03:34:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:34:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:34:14 INFO - Reading from file tmpfile_stdout 03:34:14 INFO - Detecting whether we're running mozinstall >=1.0... 03:34:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:34:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:34:14 INFO - Reading from file tmpfile_stdout 03:34:14 INFO - Output received: 03:34:14 INFO - Usage: mozinstall [options] installer 03:34:14 INFO - Options: 03:34:14 INFO - -h, --help show this help message and exit 03:34:14 INFO - -d DEST, --destination=DEST 03:34:14 INFO - Directory to install application into. [default: 03:34:14 INFO - "/builds/slave/test"] 03:34:14 INFO - --app=APP Application being installed. [default: firefox] 03:34:14 INFO - mkdir: /builds/slave/test/build/application 03:34:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:34:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:34:29 INFO - Reading from file tmpfile_stdout 03:34:29 INFO - Output received: 03:34:29 INFO - /builds/slave/test/build/application/firefox/firefox 03:34:29 INFO - Running post-action listener: _resource_record_post_action 03:34:29 INFO - ##### 03:34:29 INFO - ##### Running run-tests step. 03:34:29 INFO - ##### 03:34:29 INFO - Running pre-action listener: _resource_record_pre_action 03:34:29 INFO - Running main action method: run_tests 03:34:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:34:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:34:29 INFO - Python 2.7.3 03:34:29 INFO - Return code: 0 03:34:29 INFO - grabbing minidump binary from tooltool 03:34:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:29 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 0x16ef0b0>, '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 0x16effb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f0440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:34:29 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 03:34:29 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 03:34:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:34:29 INFO - Return code: 0 03:34:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:34:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:34:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:34:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:34:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:34:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:34:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:34:30 INFO - Return code: 0 03:34:30 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XzM3swrvSAeNyTVpz58pgw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost'] in /builds/slave/test/build 03:34:30 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XzM3swrvSAeNyTVpz58pgw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --webServer localhost 03:34:30 INFO - Using env: {'DISPLAY': ':0', 03:34:30 INFO - 'HOME': '/home/cltbld', 03:34:30 INFO - 'LANG': 'en_US.UTF-8', 03:34:30 INFO - 'LANGUAGE': 'en_US:en', 03:34:30 INFO - 'LOGNAME': 'cltbld', 03:34:30 INFO - 'MAIL': '/var/mail/cltbld', 03:34:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:34:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:34:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:30 INFO - 'MOZ_NO_REMOTE': '1', 03:34:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:34:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:30 INFO - 'NO_EM_RESTART': '1', 03:34:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:30 INFO - 'PWD': '/builds/slave/test', 03:34:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:34:30 INFO - 'SHELL': '/bin/bash', 03:34:30 INFO - 'SHLVL': '1', 03:34:30 INFO - 'TERM': 'linux', 03:34:30 INFO - 'TMOUT': '86400', 03:34:30 INFO - 'USER': 'cltbld', 03:34:30 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1448623641.758232-1609909953', 03:34:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:30 INFO - '_': '/tools/buildbot/bin/python'} 03:34:30 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XzM3swrvSAeNyTVpz58pgw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost'] with output_timeout 3600 03:34:30 INFO - mozversion INFO | application_buildid: 20151127020911 03:34:30 INFO - mozversion INFO | application_changeset: 47b49b0d32360fab04b11ff9120970979c426911 03:34:30 INFO - mozversion INFO | application_display_name: Nightly 03:34:30 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:34:30 INFO - mozversion INFO | application_name: Firefox 03:34:30 INFO - mozversion INFO | application_remotingname: firefox 03:34:30 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 03:34:30 INFO - mozversion INFO | application_vendor: Mozilla 03:34:30 INFO - mozversion INFO | application_version: 45.0a1 03:34:30 INFO - mozversion INFO | platform_buildid: 20151127020911 03:34:30 INFO - mozversion INFO | platform_changeset: 47b49b0d32360fab04b11ff9120970979c426911 03:34:30 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 03:34:30 INFO - mozversion INFO | platform_version: 45.0a1 03:34:30 INFO - 2015-11-27 03:34:30,326 DEBUG : using testdate: 1448624070 03:34:30 INFO - 2015-11-27 03:34:30,326 DEBUG : actual date: 1448624070 03:34:30 INFO - 2015-11-27 03:34:30,374 INFO : starting webserver on 'localhost:37308' 03:34:30 INFO - 2015-11-27 03:34:30,375 INFO : Starting test suite talos-linux64-ix-047 03:34:30 INFO - 2015-11-27 03:34:30,375 INFO : Starting test dromaeo_css 03:34:30 INFO - 2015-11-27 03:34:30,375 DEBUG : operating with platform_type : linux_ 03:34:30 INFO - 2015-11-27 03:34:30,376 INFO : Initialising browser for dromaeo_css test... 03:34:30 INFO - 2015-11-27 03:34:30,390 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUUj2oe/profile http://localhost:37308/getInfo.html 03:34:34 INFO - 2015-11-27 03:34:34,248 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:34:34 INFO - 2015-11-27 03:34:34,248 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:34:34 INFO - 2015-11-27 03:34:34,248 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:34:34 INFO - 2015-11-27 03:34:34,248 DEBUG : BROWSER_OUTPUT: __metrics 03:34:34 INFO - 2015-11-27 03:34:34,385 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:34:35 INFO - 2015-11-27 03:34:35,760 INFO : Browser initialized. 03:34:35 INFO - 2015-11-27 03:34:35,760 INFO : Running cycle 1/1 for dromaeo_css test... 03:34:35 INFO - 2015-11-27 03:34:35,761 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUUj2oe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:34:47 INFO - 2015-11-27 03:34:47,718 DEBUG : BROWSER_OUTPUT: RSS: Main: 141053952 03:34:47 INFO - 2015-11-27 03:34:47,718 DEBUG : BROWSER_OUTPUT: 03:35:38 INFO - 2015-11-27 03:35:38,992 DEBUG : BROWSER_OUTPUT: 1448624138989 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] 03:37:51 INFO - 2015-11-27 03:37:51,068 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37308/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37308/tests/dromaeo/cssquery-ext.html) 03:37:52 INFO - 2015-11-27 03:37:52,253 DEBUG : BROWSER_OUTPUT: RSS: Main: 258338816 03:37:52 INFO - 2015-11-27 03:37:52,254 DEBUG : BROWSER_OUTPUT: 03:40:54 INFO - 2015-11-27 03:40:54,910 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37308/tests/dromaeo/cssquery-ext.html (next: http://localhost:37308/tests/dromaeo/cssquery-jquery.html) 03:40:55 INFO - 2015-11-27 03:40:55,483 DEBUG : BROWSER_OUTPUT: RSS: Main: 226447360 03:40:55 INFO - 2015-11-27 03:40:55,483 DEBUG : BROWSER_OUTPUT: 03:43:57 INFO - 2015-11-27 03:43:57,506 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37308/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37308/tests/dromaeo/cssquery-mootools.html) 03:43:58 INFO - 2015-11-27 03:43:58,087 DEBUG : BROWSER_OUTPUT: RSS: Main: 218394624 03:43:58 INFO - 2015-11-27 03:43:58,087 DEBUG : BROWSER_OUTPUT: 03:47:00 INFO - 2015-11-27 03:46:59,999 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37308/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37308/tests/dromaeo/cssquery-prototype.html) 03:47:00 INFO - 2015-11-27 03:47:00,581 DEBUG : BROWSER_OUTPUT: RSS: Main: 204640256 03:47:00 INFO - 2015-11-27 03:47:00,581 DEBUG : BROWSER_OUTPUT: 03:50:03 INFO - 2015-11-27 03:50:03,253 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37308/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37308/tests/dromaeo/cssquery-yui.html) 03:50:03 INFO - 2015-11-27 03:50:03,833 DEBUG : BROWSER_OUTPUT: RSS: Main: 207966208 03:50:03 INFO - 2015-11-27 03:50:03,833 DEBUG : BROWSER_OUTPUT: 03:53:06 INFO - 2015-11-27 03:53:06,206 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37308/tests/dromaeo/cssquery-yui.html (next: http://localhost:37308/tests/dromaeo/cssquery-dojo.html) 03:53:06 INFO - 2015-11-27 03:53:06,455 DEBUG : BROWSER_OUTPUT: RSS: Main: 272916480 03:53:06 INFO - 2015-11-27 03:53:06,456 DEBUG : BROWSER_OUTPUT: 03:53:06 INFO - 2015-11-27 03:53:06,457 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:53:06 INFO - 2015-11-27 03:53:06,457 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:53:06 INFO - 2015-11-27 03:53:06,457 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:53:06 INFO - 2015-11-27 03:53:06,457 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:53:06 INFO - 2015-11-27 03:53:06,459 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2635.907743228987;2736.986315068427;2737.644106266185;2738.6029025791267;2755.586662000701;4527.456705195373;4645.117427688737;4728.172569800284;4736.550027747358;4750.596199323058;4671.976640116794;4673.672842900998;4726.361941137954;4757.690750101241;4793.7363445010515;4367.148406060812;4393.648508119343;4414.713043652168;4440.267355886291;4453.732776033432;4151.481064866892;4459.977700111495;4464.352668863013;4505.549445055501;4511.796969136397;4256.276433006366;4334.934975975363;4336.609705126522;4347.260965635849;4353.346997950302;4332.978335108336;4361.563843615645;4381.6494680425485;4386.276264416368;4436.64506839452;4320.805563749607;4332.91334173318;4333.9133217335475;4343.109662519176;4374.737515749065;4517.616002639779;4626.976865115653;4645.117427688729;4655.7439340836245;4668.323093151474;5031.84904452867;5034.194528875399;5034.672746271481;5036.899262014739;5039.118154322979;5002.499750024968;5071.414712774063;5107;5112.565431938289;5117.923231151536;4728.4798672146035;4729.7398643074275;4749.4775574686755;4765.571098601108;4768.47546769855;4968.205087186033;5215.973920130375;5220.504052115043;5220.530152286313;5223.268742376071;4894.339264199288;4913.115639184981;4914.311996320518;4918.729469879191;4919.114559379274;5067.113255180328;5106.387233531926;5108.948910510921;5135.435102138762;5140.460251673595;5036.622253331015;5039.874003149951;5042.470540593258;5046.873828154326;5083.745812709423;4790.353302304214;4912.975435122801;5003.924941125886;5012.097822392005;5052.242163675478;4178.456800615901;4250.468691413574;4252.893677658083;4284.100338928797;4295.656347492193;3762.774233545996;3764.7741135531955;3773.3773927301686;3794.886153415402;3805.353089974711;4191.685623578243;4307.181635489247;4378.343248512685;4378.43080399546;4424.778761061934;4972.5276098770555;5048.29323894655;5064.417591976896;5073.086844367976;5123.487651234846;4359.934600980988;4391.8462853799965;4392.758398288125;4394.494633117232;4437.866863994085;4408.757518336458;4523.7285762854335;4594.678372513892;4602.033572949651;4636.235021221461;4691.601213896789;4757.381540399864;4771.594414474808;4785.59322457595;4815.15734746411;5114.539691427789;5155.767990440364;5159.277701121921;5164.277001219907;5206.401263854554;4675.462321832897;4812.711237325771;4867.58625516835;4879.804807807648;4922.015596880567;4929.580985616263;4942.802287908444;5004.799808007639;5022.372203474566;5033.723145226902;5104.081265372269;5108.412532558655;5116.6418350716585;5120.8719782004255;5160.09698302788;4766.11826812027;4894.975525122351;4934.383202099738;4941.678790878582;4948.257761335684;4880.1215781159735;4898.730569818694;4925.605951523941;4928.901421971612;4961.7519124044375;4848.9757551212015;4870.366852309177;4875.293082503088;4914.410270767531;4921.237208232729;4706.858794236178;4989.077020751172;4989.950100499093;5008.749562521933;5047.722375269395;4719.811207551659;4795.448523419851;4821.228603423436;4837.612990960644;4838.056578967067 03:53:06 INFO - 2015-11-27 03:53:06,462 DEBUG : BROWSER_OUTPUT: |1;ext.html;573.8077743955777;575.315374704102;576.9653820770751;580.2427831679659;580.3239226301358;28544.857275713617;29027;29158.12525624232;36401.27197456049;37681.434778478346;39826;40410.59589404105;40482.190356192856;40612.39081413781;40650.796746016305;8059.355251579889;8227.095019547845;8233.259006689397;8234.464759790595;8236.011678598546;7191.604461754601;7381.372583330423;10308.020738029913;10613.097886679603;10614.469276536181;10269.794604107914;10361.274710770249;10396.272260941738;10404;10416.166706663449;6457.741690332381;6585.6707164641575;10184.847227291597;10322.535485903152;10324.328918620304;10301.587936482532;10613.787724245549;10624.36253824773;10643;10648.893511064867;37160.81419592912;37542.62457375446;37623.24753504942;37679.24641507182;37718.811405943066;2944.3669611033515;2944.690807465207;3017.637883453978;3408.897733068012;3604.6395360464007;28333.716662833314;28538.143855684364;28667.56998645022;28850.711492885013;28985.275368115756;3417.538632284635;3442.122258824009;3454.7408944329277;3529.294141171776;3559.7864128152137;221528;221698;223342;223378;224541;48527.57362131879;49708.75145624321;53775;54160.18759718607;54246.45753542493;64592;65525.34474655288;65624.01563976544;65680;66043;12769.553065642658;12975.156614820195;13039;13054.412551435209;13054.934725326313;8847.955760221286;8924.910750892537;8935.776605584912;8941.061188575106;8947.32895032875;18200.726989095176;18359.90820045918;18370.632587348176;18412.26350945947;18455.81544184568;7220.530665506725;7539.396848252127;7595.088589369311;7635.885461718079;7725.150233474314;803.9035315762146;810.7567729681072;865.8225063861893;929.0430856218106;967.6468089147411;26091.792501080196;26239.73760262373;26269.949202031705;26367.472650546883;26601.866990664923;962.4658314635444;979.4857699707568;1028.0901402259055;1056.8784589772274;1082.756379814551;13651.180929144084;13879;14006.929965350108;14019.50931717385;14107.435702571987;256920;261112;261599;261931;262573;37906.43140352897;45899.541004590195;46092.3086153708;46254.5243665887;46261.30608040882;1056.799208150449;1082.924195306321;1175.3887978251432;1195.0559058343986;1195.9521619135312;24490.87754561216;25793.226203213933;27054.45891082128;27190;28942.13173604795;36350.63649363472;37196.25607487889;37261.62738372581;42432.78783606062;42843.78578107214;315093;322923;325103;325407;325678;27447.588286176124;27773.44453110886;27776.305592360353;27887;27966.16101516958;38959.415608765325;39737.40393894152;39928.40107398333;39940.2011959765;40195.3970690434;31698.524522131724;33172.83413583013;33577;33723.83138084294;33845.492317615746;30167.396652067273;30414.239644009078;30508.154711059055;30805.38389232158;30942.38115237728;30949.0715278542;31015.844920775253;31112.066638000895;31227.53158702576;31291.530627040156;28070.578941316304;28342;31411;32914.153663796096;33066.17334566655;23213.651795222748;23343.41081429337;23510.882445587664;23519.647205291592;23680.407989799704 03:53:06 INFO - 2015-11-27 03:53:06,462 DEBUG : BROWSER_OUTPUT: |2;jquery.html;313.8964141833195;314.48424583682777;315.79631137916044;319.9008307424698;322.5468217154897;12411.503539858395;12798.36008199591;13769.655758606028;14604.926975365122;14988.325525351358;12304.692382690437;14154.43382264708;15302.23488825557;16022.118783466905;16075.919620401912;4838.371011768465;4841.443234028096;4844.442889067749;4888.87777805555;5014.2227954666905;3493.8253087345656;3600.6759391654746;4942.777575009115;4977.601791856643;5527.336719593654;5703.5152012079025;5710.714464276791;5727.713614319288;5728;5732.197492351053;5672.092465205568;6111.724972376253;6286.182796236483;6289.056641503811;6302.4958003359625;5937.168796368512;6055.666938318391;6057.939420605781;6063;6190.690465476709;21661.67507487389;21722.78277217239;21829.126834926585;22151;22264.332070037926;1855.8329750322537;1872.4663470910862;1916.3005502991448;1925.5956249187686;1984.2063174730079;13792.448302067905;13929.512467063603;13988.93005534976;14296.499622513265;14395.136291822419;1811.8356022712571;1876.3245231716571;1883.3314173468495;1943.057617055741;1960.9117589708496;49520.25719614208;50493;51023.234651480256;60193.056899675015;63836.3616363835;15451.922740386452;15477.22613869302;15495.147766872704;15515.224238788016;15523.990940588825;23045.53908921846;23113.76886231116;23291.06835726586;23342.64986025211;23376.415589610395;8237.50574965504;8243.876341854877;8280.254777069973;8284.295834853985;8322.54226017575;6648;6900.03399524067;6912.930870691329;6918.481113916477;6932.549384290005;7586.544807311579;7590.430717696195;7590.533076750078;7603.239676032353;7610.9238907611325;1538.8922775405615;1630.8613767829868;1644.6792875389185;2142.1762154554044;2888.4367548328296;307.90762771169005;310.86011294917375;328.9325688233906;761.5963539324167;906.8186362727481;8916.331275154389;9279.860802087975;9346.53267336644;15150.393984240507;15594.376224951102;817.284875733733;829.2536716954669;830.6511265268601;851.936104792143;936.1387523478417;8509.10654381281;8631.395802293779;8702.521361325187;8820.382573219813;8870.246029087471;432917;506144;511796;512270;519039;71380;71436.64281678663;73154.63422682852;74789.62605186939;75846.24153758503;1045.8378951262414;1048.9527971241312;1055.4406164732704;1055.4458909072798;1073.8013467508536;13580.93209533946;14337.498187563386;14374.784378234544;14423.567292981228;14440.711185776436;30416.391672166876;30579.847100765244;30923.226919327197;31514.842425787723;31731.524027140073;40774.388384174854;40903.795481022404;42226.788866055475;42785.57214427816;44635;7925.28672419485;8134.83730325402;8165.469244499089;8227.794305142419;8238.134995825352;9344;9357.625694972125;9422.858657120285;9485.288603354638;13561;13655.385507651981;13683.589492315246;13829.446822127406;13997.160170389809;14055.086419382707;12904;13245.933770331087;13320.400581973641;13513.662158446117;13905;13346.466141354236;13363.465461381436;13587.728245435233;13775.38010789497;13934;8099.959500202697;8105.594720263845;8151.5109093454585;8532.829343412974;8544.57277136153;8546;10303.433311167957;12862.228266303677;13851.653708657364;13991.650208744863 03:53:06 INFO - 2015-11-27 03:53:06,463 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1188.6612315490088;1354.3769865861702;1389.0485017762833;1598.0811033655648;1675.958101047474;5678.914816277754;6373.904391434126;6714.194296684393;6719.0257412675255;6724.193096828375;6611.636360000198;6612.404883560479;6681.265060843303;6688.732450701966;6690.565113267634;1668.8414600612923;1705.8123606403285;1927.4892153579349;1967.6359873423391;1967.803219678035;1960.5980773941308;2011.3563659628924;2014.53665656899;2015.5465020370445;2016.9294074707389;1906.4376009077287;1927.8361339286178;1929.8649094563386;1962.4014675523958;1963.5385684364162;1966.2528239269059;1976.10087410228;2007.985967086612;2012.9194832206622;2014.9899250503727;1998.7701414337391;2011.7686466056446;2015.2745011795741;2018.3743039657606;2022.7269318641943;6594.1427614410295;6611.239707433659;6663.566868153554;6664.233613134503;6667.6666166691475;3672.210474747915;3745.0637340664834;3764.7741135531683;3779.829907654162;3780.546334439857;2509.2848538166536;2560.167945417728;2601.609758536216;2607.5436798560177;2627.7240889706495;767.382257282887;841.4320333774739;901.6123067081153;921.5760750054983;921.663592788634;8557.786055348604;8660.8700869487;8719.564021798884;8721.825563488757;8743.300535957109;3438.449848024304;3492.371373152806;3505.2288496530723;3505.8948231553095;3522.5949015862993;7609.847803044019;7616.581088040211;7660.578668173192;7671.808204794925;7675.117361503387;3824.4263360495593;3832.789196594214;3843.1160833008566;3844.038990252437;3863.6715879150024;3492.89521314361;3506.859725610947;3510.1575621851084;3512.2624248907505;3517.7009954153673;3177.1421716136515;3182.5226216067776;3183.0291761013114;3189.186757376854;3210.06907996683;966.5602151021268;966.8598053282235;970.3838062830154;972.1445128287062;973.868527748759;1112.5939032253332;1143.2511704833348;1150.7295785490403;1176.858776946772;1176.9882301176879;6095.329513753483;6114.633122012693;6168.568200225941;6170.321264660884;6194.0708893665405;1066.7706443114769;1096.4901320885667;1108.933463992163;1111.0778054215143;1118.3457677258732;4985.551300382983;4991.176455884738;5033.672811267256;5033.874153146201;5040.697558146523;6673.265940746514;7257.310555497219;7461.888071678929;7517.924820751832;7602.277783610548;6624.403803657694;7576.3181313682035;7667.0416197975255;7747.225277472207;7766.106897706836;5949.851253718692;6037.818865434044;6044;6064.332923378425;6066.75732970685;6086.878262434815;6135.509159267159;6152.723127459186;6162.352952939877;6215.844603884939;6804.931950680628;6884;6884.827879303058;6892.276930767308;6918.930810691829;6889.069975553236;7015.894761578478;7040.788776336718;7041.084658994298;7056.576605403692;5876.559258055749;5934.3175534814045;5978.641281523122;5978.940210597838;5999.640021598718;6268.153799237045;6270;6282.089097080806;6294.402031806971;6296.590721603081;5819.5053420459735;5903.203067585992;5910.261217347832;6008.218931538872;6012.128241404885;6072.05883088122;6105.8168254952425;6164.106204600397;6184.783532576338;6226.470749986302;5924.607717186372;5951.702414879325;5953.583249172516;5971.402859713994;5984.042553191469;5490.176473529003;5540.806071787468;5550.222968784293;5570.721463926707;5592.496675299242;5534.1975413564005;5545.667259964415;5562.888742225052;5576.414476479911;5587.916181257366 03:53:06 INFO - 2015-11-27 03:53:06,464 DEBUG : BROWSER_OUTPUT: |4;prototype.html;285.5032243895622;290.03274080940065;290.26273265904604;291.82636331382827;299.40119760479047;5034.572061374778;5363.195520671901;5451.100568406218;5458.6724796512135;5470.343558772943;5026.623003274751;5154.819581314655;5183.637145399824;5361.088614935461;5367.409584945653;4120.773357465338;4137.544870064298;4138.751674899516;4139.7309174903685;4142.233686767958;3913.921721565567;4135.875923722293;4135.979320103395;4141.958580414187;4144.730592511477;3956.248312820555;3996.9200615987806;4004.659603933669;4048.1701251243426;4115.012397024708;4085.2850751118585;4087.264292427362;4091.85678501251;4098.549159592442;4105.486814148247;3559.199180184464;3566.4293713006055;3571.482135090397;3572.089117275078;3573.4282514797505;5072.188449848043;5079.3650793650795;5084.593232541388;5094.592432605383;5096.9490305097215;4650.0932318197965;4723.527647235283;4800.279958006292;4807.471178170398;4819.614430845524;5664.54683625309;5674.319081710221;5675.34733505648;5681.602287839853;5684.715764211773;3988.0827409695644;3994.7603143811466;3995.1011022519992;3999.14018486024;4003.679705623543;5945.375735547748;5973.701314934236;5976.8505787355225;5981.850453738648;5981.8803623927715;4017.5982401760175;4110.609492098246;4117;4123.525794533607;4136.324788460678;4173.791310434527;4185.016521117535;4185.790710464465;4190.371444283382;4190.497140343178;4766.308885211694;4768.499307572724;4773.856784296477;4777.378940737752;4779.402574678165;5661.150827375926;5670.8015219467125;5676.4323567642905;5684.8010319638615;5686.60193786431;1439.992800035993;1449.3043339197245;1482.792409062732;1483.8738707209793;1484.5843163914121;994.4431118573622;1003.2626019875386;1010.2927950434726;1024.2522958240527;1029.6190409548515;4981.053599816023;4995.275685025651;4995.600351971833;4997.25041243809;4997.625178111583;5898.8230353089475;5900.203472531153;5902.498287645512;5904;5908.143319218775;4824.49342819006;4916.704997700078;4967.5529202371235;4987.0524600325825;4992.552159873669;3176.6029246344206;3203.6636153204045;3209.9679003210135;3211.1811488070393;3218.291975765328;5618.073017952074;5618.241537392481;5619.325680918234;5625.915611265835;5627.324721033502;5967.224260846149;6098.939010609926;6108.602940808833;6108.877822443526;6111;5621.100623900156;5634.183043458757;5637.182608521824;5640.605157639008;5643.097104463348;5951.166836642787;5953.464188222907;5957.672328022;5958.940410596012;5960.701964901651;5761.39505351932;5800.651960882361;5808.30300363959;5814.592978491465;5818.214541037075;5487.396386397573;5630.549556035426;5631.070873306023;5635.239242702182;5635.464630860061;4123.711340206157;4133.731307465006;4135.524414692349;4136.31750761121;4140.047789008485;5939.851503712269;5943.821685349447;5947.31605865331;5947.940520594739;5958.821235362946;5617.747201375866;5689.34572524165;5721.199032135588;5733.397993210653;5733.8566535836935;5710.114932185518;5714.885702285847;5715.428457154251;5724.942750572441;5731.684757338387;5604.271444712162;5608.9158662619275;5610.410906854721;5611.9337325907945;5618.016847051668;5747.396523364986;5747.453991870766;5755.884882302415;5756.568257380797;5761.251037365116;5423.647462914898;5606.971965140311;5616;5619.466150715675;5626.85932851682 03:53:06 INFO - 2015-11-27 03:53:06,465 DEBUG : BROWSER_OUTPUT: |5;yui.html;672.8250654829743;682.8122266376749;776.6194564663315;789.5578476053411;791.9841603167937;10818.242723009393;10947.397893115876;10951.561937522489;10969;11013.063889569386;10669.679909602704;10754.569817207303;10784.78430431391;10788.784224315528;10853.565857365697;597.4622839444502;613.5613036678774;614.0819474885053;756.4704706705301;775.9418043646721;771.1786946901532;771.5717776633966;778.5756762564388;779;779.4660657449665;764.7591008832228;773.288574511448;773.8684423647965;774.4075782026754;775.4726785785664;619.63441569474;630.8864404407228;777.5956502618664;792.4809249941297;795.2723258218723;597.8744463662636;598.6198763785028;598.6647477412663;598.7634884220752;598.7664810723821;10350.844737328945;10402;10412.42731649759;10419.79160416795;10435.895641043568;10639.468026598717;11520.94239528797;11544.769104617944;11814.17300788945;11822.763544729143;9023.458592484407;9099.81800363989;9112.407693499901;9112.544372781334;9113.362064655477;3219.7746157768966;3220.677932206784;3252.593425821772;3256.446404111307;3297.241634424072;40244.59755402467;40333;40354.596454035374;40403.191936161405;40484.59515404838;9562.61749530025;9789.608415663437;9809.509524523744;9916.702498925044;9936.751581210528;16889.155542223085;17016.57458563521;17020.14899255057;17022.744658830128;17028.659426811642;5983.252093488314;6045.33501314855;6149.600275982047;6153.876922461615;6168.1056246843955;3456.1705190754037;3518.3029362307634;3543.5039094526787;3565.286942611488;3628.63713628635;2641.881115349814;2657.4286528396487;2676.0901293560282;2685.5971604259125;2689.1529168311918;468.8851231448249;471.4460508902026;476.58775159486794;480.9879753006203;483.1134867518144;574.4600075928614;575.8877018981259;580.7676929228343;595.8986972214734;606.8088552106072;6832.829179270459;7221.350078492856;7296.489245752852;8153.02163740355;8311.210435008665;483.7339463295174;541.9647722898;545.4218528359951;592.7125344208056;639.9161284579659;3511.122219445139;3693.1874987502706;3739.607341229186;3787.1857550626746;3848.9807550962064;49414.25878611824;51012.74493627508;51069.74465127725;51316.48683513192;51342.74328628408;45109.097818043454;45134.77432612816;45697.54302457;46018.76990615026;46206;42988.57011429908;43591;43886.78056609697;44043.33934990978;44133.33799993002;7060;7077.469189810682;7110.4537468109675;7271.8909216360735;7312.561246325237;30736.38527229398;31093.222669433446;31770.523442147925;32087.83956080298;32447;36404.635953641184;36606.63393366139;37598.248035039695;41187.794061029505;41230.79384603058;8934.910650893667;9197.448153110834;9261.53692315395;9322.813543729224;9409.48247846375;10205.691883978741;10214.591416343263;10253.948730256301;10532.736681583021;10607.151427885905;9370.625174992923;9610;9646.855297170408;9699.6120155193;9891.752706182404;9396.812063758824;9419.246460283299;9485.430874147572;9547;9656.468894210886;9802.215822734306;9889.456079915673;9923.702288931343;10213.285070045025;10476.738081548023;8927.776805579913;9038.697390593341;9300.488473134043;9497.192738617296;9553.092456216647;8605.569721513773;8728.91271087281;8903;8919.821603568022;9245.214156796748 03:53:06 INFO - 2015-11-27 03:53:06,465 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:53:06 INFO - 2015-11-27 03:53:06,465 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:53:06 INFO - 2015-11-27 03:53:06,465 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,976 03:53:06 INFO - 2015-11-27 03:53:06,465 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:53:06 INFO - 2015-11-27 03:53:06,465 DEBUG : BROWSER_OUTPUT: __startTimestamp1448625186456__endTimestamp 03:53:06 INFO - 2015-11-27 03:53:06,465 DEBUG : BROWSER_OUTPUT: 03:53:06 INFO - 2015-11-27 03:53:06,466 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:53:06 INFO - 2015-11-27 03:53:06,466 DEBUG : BROWSER_OUTPUT: Number of tests: 6 03:53:06 INFO - 2015-11-27 03:53:06,466 DEBUG : BROWSER_OUTPUT: 03:53:06 INFO - 2015-11-27 03:53:06,466 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4678.17 Median:4790.35 stddev:479.53 (10.0%) stddev-sans-first:453.45 03:53:06 INFO - 2015-11-27 03:53:06,467 DEBUG : BROWSER_OUTPUT: Values: 2635.9 2737.0 2737.6 2738.6 2755.6 4527.5 4645.1 4728.2 4736.6 4750.6 4672.0 4673.7 4726.4 4757.7 4793.7 4367.1 4393.6 4414.7 4440.3 4453.7 4151.5 4460.0 4464.4 4505.5 4511.8 4256.3 4334.9 4336.6 4347.3 4353.3 4333.0 4361.6 4381.6 4386.3 4436.6 4320.8 4332.9 4333.9 4343.1 4374.7 4517.6 4627.0 4645.1 4655.7 4668.3 5031.8 5034.2 5034.7 5036.9 5039.1 5002.5 5071.4 5107.0 5112.6 5117.9 4728.5 4729.7 4749.5 4765.6 4768.5 4968.2 5216.0 5220.5 5220.5 5223.3 4894.3 4913.1 4914.3 4918.7 4919.1 5067.1 5106.4 5108.9 5135.4 5140.5 5036.6 5039.9 5042.5 5046.9 5083.7 4790.4 4913.0 5003.9 5012.1 5052.2 4178.5 4250.5 4252.9 4284.1 4295.7 3762.8 3764.8 3773.4 3794.9 3805.4 4191.7 4307.2 4378.3 4378.4 4424.8 4972.5 5048.3 5064.4 5073.1 5123.5 4359.9 4391.8 4392.8 4394.5 4437.9 4408.8 4523.7 4594.7 4602.0 4636.2 4691.6 4757.4 4771.6 4785.6 4815.2 5114.5 5155.8 5159.3 5164.3 5206.4 4675.5 4812.7 4867.6 4879.8 4922.0 4929.6 4942.8 5004.8 5022.4 5033.7 5104.1 5108.4 5116.6 5120.9 5160.1 4766.1 4895.0 4934.4 4941.7 4948.3 4880.1 4898.7 4925.6 4928.9 4961.8 4849.0 4870.4 4875.3 4914.4 4921.2 4706.9 4989.1 4990.0 5008.7 5047.7 4719.8 4795.4 4821.2 4837.6 4838.1 03:53:06 INFO - 2015-11-27 03:53:06,467 DEBUG : BROWSER_OUTPUT: 03:53:06 INFO - 2015-11-27 03:53:06,467 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42650.02 Median:31259.53 stddev:71206.07 (227.8%) stddev-sans-first:71335.74 03:53:06 INFO - 2015-11-27 03:53:06,467 DEBUG : BROWSER_OUTPUT: Values: 573.8 575.3 577.0 580.2 580.3 28544.9 29027.0 29158.1 36401.3 37681.4 39826.0 40410.6 40482.2 40612.4 40650.8 8059.4 8227.1 8233.3 8234.5 8236.0 7191.6 7381.4 10308.0 10613.1 10614.5 10269.8 10361.3 10396.3 10404.0 10416.2 6457.7 6585.7 10184.8 10322.5 10324.3 10301.6 10613.8 10624.4 10643.0 10648.9 37160.8 37542.6 37623.2 37679.2 37718.8 2944.4 2944.7 3017.6 3408.9 3604.6 28333.7 28538.1 28667.6 28850.7 28985.3 3417.5 3442.1 3454.7 3529.3 3559.8 221528.0 221698.0 223342.0 223378.0 224541.0 48527.6 49708.8 53775.0 54160.2 54246.5 64592.0 65525.3 65624.0 65680.0 66043.0 12769.6 12975.2 13039.0 13054.4 13054.9 8848.0 8924.9 8935.8 8941.1 8947.3 18200.7 18359.9 18370.6 18412.3 18455.8 7220.5 7539.4 7595.1 7635.9 7725.2 803.9 810.8 865.8 929.0 967.6 26091.8 26239.7 26269.9 26367.5 26601.9 962.5 979.5 1028.1 1056.9 1082.8 13651.2 13879.0 14006.9 14019.5 14107.4 256920.0 261112.0 261599.0 261931.0 262573.0 37906.4 45899.5 46092.3 46254.5 46261.3 1056.8 1082.9 1175.4 1195.1 1196.0 24490.9 25793.2 27054.5 27190.0 28942.1 36350.6 37196.3 37261.6 42432.8 42843.8 315093.0 322923.0 325103.0 325407.0 325678.0 27447.6 27773.4 27776.3 27887.0 27966.2 38959.4 39737.4 39928.4 39940.2 40195.4 31698.5 33172.8 33577.0 33723.8 33845.5 30167.4 30414.2 30508.2 30805.4 30942.4 30949.1 31015.8 31112.1 31227.5 31291.5 28070.6 28342.0 31411.0 32914.2 33066.2 23213.7 23343.4 23510.9 23519.6 23680.4 03:53:06 INFO - 2015-11-27 03:53:06,467 DEBUG : BROWSER_OUTPUT: 03:53:06 INFO - 2015-11-27 03:53:06,468 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27051.09 Median:3547.25 stddev:81174.15 (2288.4%) stddev-sans-first:81377.03 03:53:06 INFO - 2015-11-27 03:53:06,468 DEBUG : BROWSER_OUTPUT: Values: 313.9 314.5 315.8 319.9 322.5 12411.5 12798.4 13769.7 14604.9 14988.3 12304.7 14154.4 15302.2 16022.1 16075.9 4838.4 4841.4 4844.4 4888.9 5014.2 3493.8 3600.7 4942.8 4977.6 5527.3 5703.5 5710.7 5727.7 5728.0 5732.2 5672.1 6111.7 6286.2 6289.1 6302.5 5937.2 6055.7 6057.9 6063.0 6190.7 21661.7 21722.8 21829.1 22151.0 22264.3 1855.8 1872.5 1916.3 1925.6 1984.2 13792.4 13929.5 13988.9 14296.5 14395.1 1811.8 1876.3 1883.3 1943.1 1960.9 49520.3 50493.0 51023.2 60193.1 63836.4 15451.9 15477.2 15495.1 15515.2 15524.0 23045.5 23113.8 23291.1 23342.6 23376.4 8237.5 8243.9 8280.3 8284.3 8322.5 6648.0 6900.0 6912.9 6918.5 6932.5 7586.5 7590.4 7590.5 7603.2 7610.9 1538.9 1630.9 1644.7 2142.2 2888.4 307.9 310.9 328.9 761.6 906.8 8916.3 9279.9 9346.5 15150.4 15594.4 817.3 829.3 830.7 851.9 936.1 8509.1 8631.4 8702.5 8820.4 8870.2 432917.0 506144.0 511796.0 512270.0 519039.0 71380.0 71436.6 73154.6 74789.6 75846.2 1045.8 1049.0 1055.4 1055.4 1073.8 13580.9 14337.5 14374.8 14423.6 14440.7 30416.4 30579.8 30923.2 31514.8 31731.5 40774.4 40903.8 42226.8 42785.6 44635.0 7925.3 8134.8 8165.5 8227.8 8238.1 9344.0 9357.6 9422.9 9485.3 13561.0 13655.4 13683.6 13829.4 13997.2 14055.1 12904.0 13245.9 13320.4 13513.7 13905.0 13346.5 13363.5 13587.7 13775.4 13934.0 8100.0 8105.6 8151.5 8532.8 8544.6 8546.0 10303.4 12862.2 13851.7 13991.7 03:53:06 INFO - 2015-11-27 03:53:06,468 DEBUG : BROWSER_OUTPUT: 03:53:06 INFO - 2015-11-27 03:53:06,468 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4587.71 Median:5929.46 stddev:2305.10 (38.9%) stddev-sans-first:2297.40 03:53:06 INFO - 2015-11-27 03:53:06,469 DEBUG : BROWSER_OUTPUT: Values: 1188.7 1354.4 1389.0 1598.1 1676.0 5678.9 6373.9 6714.2 6719.0 6724.2 6611.6 6612.4 6681.3 6688.7 6690.6 1668.8 1705.8 1927.5 1967.6 1967.8 1960.6 2011.4 2014.5 2015.5 2016.9 1906.4 1927.8 1929.9 1962.4 1963.5 1966.3 1976.1 2008.0 2012.9 2015.0 1998.8 2011.8 2015.3 2018.4 2022.7 6594.1 6611.2 6663.6 6664.2 6667.7 3672.2 3745.1 3764.8 3779.8 3780.5 2509.3 2560.2 2601.6 2607.5 2627.7 767.4 841.4 901.6 921.6 921.7 8557.8 8660.9 8719.6 8721.8 8743.3 3438.4 3492.4 3505.2 3505.9 3522.6 7609.8 7616.6 7660.6 7671.8 7675.1 3824.4 3832.8 3843.1 3844.0 3863.7 3492.9 3506.9 3510.2 3512.3 3517.7 3177.1 3182.5 3183.0 3189.2 3210.1 966.6 966.9 970.4 972.1 973.9 1112.6 1143.3 1150.7 1176.9 1177.0 6095.3 6114.6 6168.6 6170.3 6194.1 1066.8 1096.5 1108.9 1111.1 1118.3 4985.6 4991.2 5033.7 5033.9 5040.7 6673.3 7257.3 7461.9 7517.9 7602.3 6624.4 7576.3 7667.0 7747.2 7766.1 5949.9 6037.8 6044.0 6064.3 6066.8 6086.9 6135.5 6152.7 6162.4 6215.8 6804.9 6884.0 6884.8 6892.3 6918.9 6889.1 7015.9 7040.8 7041.1 7056.6 5876.6 5934.3 5978.6 5978.9 5999.6 6268.2 6270.0 6282.1 6294.4 6296.6 5819.5 5903.2 5910.3 6008.2 6012.1 6072.1 6105.8 6164.1 6184.8 6226.5 5924.6 5951.7 5953.6 5971.4 5984.0 5490.2 5540.8 5550.2 5570.7 5592.5 5534.2 5545.7 5562.9 5576.4 5587.9 03:53:06 INFO - 2015-11-27 03:53:06,470 DEBUG : BROWSER_OUTPUT: 03:53:06 INFO - 2015-11-27 03:53:06,470 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4712.93 Median:5125.88 stddev:1393.62 (27.2%) stddev-sans-first:1357.33 03:53:06 INFO - 2015-11-27 03:53:06,470 DEBUG : BROWSER_OUTPUT: Values: 285.5 290.0 290.3 291.8 299.4 5034.6 5363.2 5451.1 5458.7 5470.3 5026.6 5154.8 5183.6 5361.1 5367.4 4120.8 4137.5 4138.8 4139.7 4142.2 3913.9 4135.9 4136.0 4142.0 4144.7 3956.2 3996.9 4004.7 4048.2 4115.0 4085.3 4087.3 4091.9 4098.5 4105.5 3559.2 3566.4 3571.5 3572.1 3573.4 5072.2 5079.4 5084.6 5094.6 5096.9 4650.1 4723.5 4800.3 4807.5 4819.6 5664.5 5674.3 5675.3 5681.6 5684.7 3988.1 3994.8 3995.1 3999.1 4003.7 5945.4 5973.7 5976.9 5981.9 5981.9 4017.6 4110.6 4117.0 4123.5 4136.3 4173.8 4185.0 4185.8 4190.4 4190.5 4766.3 4768.5 4773.9 4777.4 4779.4 5661.2 5670.8 5676.4 5684.8 5686.6 1440.0 1449.3 1482.8 1483.9 1484.6 994.4 1003.3 1010.3 1024.3 1029.6 4981.1 4995.3 4995.6 4997.3 4997.6 5898.8 5900.2 5902.5 5904.0 5908.1 4824.5 4916.7 4967.6 4987.1 4992.6 3176.6 3203.7 3210.0 3211.2 3218.3 5618.1 5618.2 5619.3 5625.9 5627.3 5967.2 6098.9 6108.6 6108.9 6111.0 5621.1 5634.2 5637.2 5640.6 5643.1 5951.2 5953.5 5957.7 5958.9 5960.7 5761.4 5800.7 5808.3 5814.6 5818.2 5487.4 5630.5 5631.1 5635.2 5635.5 4123.7 4133.7 4135.5 4136.3 4140.0 5939.9 5943.8 5947.3 5947.9 5958.8 5617.7 5689.3 5721.2 5733.4 5733.9 5710.1 5714.9 5715.4 5724.9 5731.7 5604.3 5608.9 5610.4 5611.9 5618.0 5747.4 5747.5 5755.9 5756.6 5761.3 5423.6 5607.0 5616.0 5619.5 5626.9 03:53:06 INFO - 2015-11-27 03:53:06,470 DEBUG : BROWSER_OUTPUT: 03:53:06 INFO - 2015-11-27 03:53:06,470 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12142.12 Median:575.17 stddev:14158.06 (2461.5%) stddev-sans-first:14171.58 03:53:06 INFO - 2015-11-27 03:53:06,471 DEBUG : BROWSER_OUTPUT: Values: 672.8 682.8 776.6 789.6 792.0 10818.2 10947.4 10951.6 10969.0 11013.1 10669.7 10754.6 10784.8 10788.8 10853.6 597.5 613.6 614.1 756.5 775.9 771.2 771.6 778.6 779.0 779.5 764.8 773.3 773.9 774.4 775.5 619.6 630.9 777.6 792.5 795.3 597.9 598.6 598.7 598.8 598.8 10350.8 10402.0 10412.4 10419.8 10435.9 10639.5 11520.9 11544.8 11814.2 11822.8 9023.5 9099.8 9112.4 9112.5 9113.4 3219.8 3220.7 3252.6 3256.4 3297.2 40244.6 40333.0 40354.6 40403.2 40484.6 9562.6 9789.6 9809.5 9916.7 9936.8 16889.2 17016.6 17020.1 17022.7 17028.7 5983.3 6045.3 6149.6 6153.9 6168.1 3456.2 3518.3 3543.5 3565.3 3628.6 2641.9 2657.4 2676.1 2685.6 2689.2 468.9 471.4 476.6 481.0 483.1 574.5 575.9 580.8 595.9 606.8 6832.8 7221.4 7296.5 8153.0 8311.2 483.7 542.0 545.4 592.7 639.9 3511.1 3693.2 3739.6 3787.2 3849.0 49414.3 51012.7 51069.7 51316.5 51342.7 45109.1 45134.8 45697.5 46018.8 46206.0 42988.6 43591.0 43886.8 44043.3 44133.3 7060.0 7077.5 7110.5 7271.9 7312.6 30736.4 31093.2 31770.5 32087.8 32447.0 36404.6 36606.6 37598.2 41187.8 41230.8 8934.9 9197.4 9261.5 9322.8 9409.5 10205.7 10214.6 10253.9 10532.7 10607.2 9370.6 9610.0 9646.9 9699.6 9891.8 9396.8 9419.2 9485.4 9547.0 9656.5 9802.2 9889.5 9923.7 10213.3 10476.7 8927.8 9038.7 9300.5 9497.2 9553.1 8605.6 8728.9 8903.0 8919.8 9245.2 03:53:06 INFO - 2015-11-27 03:53:06,471 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:53:06 INFO - 2015-11-27 03:53:06,471 DEBUG : BROWSER_OUTPUT: 03:53:07 INFO - 2015-11-27 03:53:07,197 INFO : Browser exited with error code: 0 03:53:07 INFO - 2015-11-27 03:53:07,213 INFO : Completed test dromaeo_css (00:18:36) 03:53:07 INFO - 2015-11-27 03:53:07,214 INFO : Starting test kraken 03:53:07 INFO - 2015-11-27 03:53:07,214 DEBUG : operating with platform_type : linux_ 03:53:07 INFO - 2015-11-27 03:53:07,214 INFO : Initialising browser for kraken test... 03:53:07 INFO - 2015-11-27 03:53:07,220 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFexpAF/profile http://localhost:37308/getInfo.html 03:53:11 INFO - 2015-11-27 03:53:11,066 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:53:11 INFO - 2015-11-27 03:53:11,067 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:53:11 INFO - 2015-11-27 03:53:11,067 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:53:11 INFO - 2015-11-27 03:53:11,067 DEBUG : BROWSER_OUTPUT: __metrics 03:53:11 INFO - 2015-11-27 03:53:11,216 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:53:12 INFO - 2015-11-27 03:53:12,439 INFO : Browser initialized. 03:53:12 INFO - 2015-11-27 03:53:12,439 INFO : Running cycle 1/1 for kraken test... 03:53:12 INFO - 2015-11-27 03:53:12,439 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFexpAF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:53:24 INFO - 2015-11-27 03:53:24,202 DEBUG : BROWSER_OUTPUT: RSS: Main: 138883072 03:53:24 INFO - 2015-11-27 03:53:24,203 DEBUG : BROWSER_OUTPUT: 03:53:26 INFO - 2015-11-27 03:53:26,764 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37308/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37308/tests/kraken/driver.html?testName=audio-beat-detection) 03:53:27 INFO - 2015-11-27 03:53:27,350 DEBUG : BROWSER_OUTPUT: RSS: Main: 176373760 03:53:27 INFO - 2015-11-27 03:53:27,351 DEBUG : BROWSER_OUTPUT: 03:53:30 INFO - 2015-11-27 03:53:30,072 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37308/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37308/tests/kraken/driver.html?testName=audio-dft) 03:53:30 INFO - 2015-11-27 03:53:30,646 DEBUG : BROWSER_OUTPUT: RSS: Main: 165249024 03:53:30 INFO - 2015-11-27 03:53:30,646 DEBUG : BROWSER_OUTPUT: 03:53:33 INFO - 2015-11-27 03:53:33,591 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37308/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37308/tests/kraken/driver.html?testName=audio-fft) 03:53:34 INFO - 2015-11-27 03:53:34,172 DEBUG : BROWSER_OUTPUT: RSS: Main: 149622784 03:53:34 INFO - 2015-11-27 03:53:34,172 DEBUG : BROWSER_OUTPUT: 03:53:36 INFO - 2015-11-27 03:53:36,204 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37308/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37308/tests/kraken/driver.html?testName=audio-oscillator) 03:53:36 INFO - 2015-11-27 03:53:36,777 DEBUG : BROWSER_OUTPUT: RSS: Main: 152494080 03:53:36 INFO - 2015-11-27 03:53:36,777 DEBUG : BROWSER_OUTPUT: 03:53:39 INFO - 2015-11-27 03:53:39,020 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37308/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37308/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:53:39 INFO - 2015-11-27 03:53:39,587 DEBUG : BROWSER_OUTPUT: RSS: Main: 154927104 03:53:39 INFO - 2015-11-27 03:53:39,587 DEBUG : BROWSER_OUTPUT: 03:53:42 INFO - 2015-11-27 03:53:42,578 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37308/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37308/tests/kraken/driver.html?testName=imaging-darkroom) 03:53:43 INFO - 2015-11-27 03:53:43,158 DEBUG : BROWSER_OUTPUT: RSS: Main: 155856896 03:53:43 INFO - 2015-11-27 03:53:43,158 DEBUG : BROWSER_OUTPUT: 03:53:46 INFO - 2015-11-27 03:53:46,620 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37308/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37308/tests/kraken/driver.html?testName=imaging-desaturate) 03:53:47 INFO - 2015-11-27 03:53:47,202 DEBUG : BROWSER_OUTPUT: RSS: Main: 154800128 03:53:47 INFO - 2015-11-27 03:53:47,202 DEBUG : BROWSER_OUTPUT: 03:53:50 INFO - 2015-11-27 03:53:50,024 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37308/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37308/tests/kraken/driver.html?testName=json-parse-financial) 03:53:50 INFO - 2015-11-27 03:53:50,610 DEBUG : BROWSER_OUTPUT: RSS: Main: 156565504 03:53:50 INFO - 2015-11-27 03:53:50,610 DEBUG : BROWSER_OUTPUT: 03:53:52 INFO - 2015-11-27 03:53:52,380 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37308/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37308/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:53:52 INFO - 2015-11-27 03:53:52,945 DEBUG : BROWSER_OUTPUT: RSS: Main: 165986304 03:53:52 INFO - 2015-11-27 03:53:52,946 DEBUG : BROWSER_OUTPUT: 03:53:54 INFO - 2015-11-27 03:53:54,841 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37308/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37308/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:53:55 INFO - 2015-11-27 03:53:55,447 DEBUG : BROWSER_OUTPUT: RSS: Main: 164257792 03:53:55 INFO - 2015-11-27 03:53:55,447 DEBUG : BROWSER_OUTPUT: 03:53:57 INFO - 2015-11-27 03:53:57,551 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37308/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37308/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:53:58 INFO - 2015-11-27 03:53:58,132 DEBUG : BROWSER_OUTPUT: RSS: Main: 177115136 03:53:58 INFO - 2015-11-27 03:53:58,132 DEBUG : BROWSER_OUTPUT: 03:54:00 INFO - 2015-11-27 03:54:00,687 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37308/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37308/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:54:01 INFO - 2015-11-27 03:54:01,273 DEBUG : BROWSER_OUTPUT: RSS: Main: 182206464 03:54:01 INFO - 2015-11-27 03:54:01,274 DEBUG : BROWSER_OUTPUT: 03:54:03 INFO - 2015-11-27 03:54:03,877 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37308/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37308/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:54:04 INFO - 2015-11-27 03:54:04,460 DEBUG : BROWSER_OUTPUT: RSS: Main: 180232192 03:54:04 INFO - 2015-11-27 03:54:04,460 DEBUG : BROWSER_OUTPUT: 03:54:06 INFO - 2015-11-27 03:54:06,191 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37308/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37308/tests/kraken/driver.html?testName=ai-astar) 03:54:06 INFO - 2015-11-27 03:54:06,441 DEBUG : BROWSER_OUTPUT: RSS: Main: 239153152 03:54:06 INFO - 2015-11-27 03:54:06,441 DEBUG : BROWSER_OUTPUT: 03:54:06 INFO - 2015-11-27 03:54:06,444 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:54:06 INFO - 2015-11-27 03:54:06,445 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:54:06 INFO - 2015-11-27 03:54:06,445 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:54:06 INFO - 2015-11-27 03:54:06,445 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:54:06 INFO - 2015-11-27 03:54:06,445 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;112;105;112;113;112;100;112;112;101 03:54:06 INFO - 2015-11-27 03:54:06,445 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;131;158;170;132;148;150;135;165;129 03:54:06 INFO - 2015-11-27 03:54:06,445 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;163;160;161;161;161;163;162;161 03:54:06 INFO - 2015-11-27 03:54:06,445 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;96;87;91;72;76;72;91;94;72 03:54:06 INFO - 2015-11-27 03:54:06,446 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;95;128;94;94;95;130;94;96;127 03:54:06 INFO - 2015-11-27 03:54:06,446 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;109;110;110;110;111;109;109;109 03:54:06 INFO - 2015-11-27 03:54:06,446 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;146;146;147;148;146;146;149;147 03:54:06 INFO - 2015-11-27 03:54:06,446 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;96;95;95;95;95;95;95;96 03:54:06 INFO - 2015-11-27 03:54:06,446 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;71;71;70;71;71;72;72;71;70 03:54:06 INFO - 2015-11-27 03:54:06,446 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;68;68;69;70;68;69;71;69;69 03:54:06 INFO - 2015-11-27 03:54:06,446 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;84;86;84;84;84;85;84;85;84 03:54:06 INFO - 2015-11-27 03:54:06,447 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;128;120;127;125;125;127;128;125;130;131 03:54:06 INFO - 2015-11-27 03:54:06,447 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;154;136;149;145;148;134;151;160;140;136 03:54:06 INFO - 2015-11-27 03:54:06,447 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;70;67;69;70;69;70;68;70;67 03:54:06 INFO - 2015-11-27 03:54:06,447 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:54:06 INFO - 2015-11-27 03:54:06,447 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:54:06 INFO - 2015-11-27 03:54:06,447 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,997 03:54:06 INFO - 2015-11-27 03:54:06,447 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:54:06 INFO - 2015-11-27 03:54:06,448 DEBUG : BROWSER_OUTPUT: __startTimestamp1448625246443__endTimestamp 03:54:06 INFO - 2015-11-27 03:54:06,448 DEBUG : BROWSER_OUTPUT: 03:54:06 INFO - 2015-11-27 03:54:06,451 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:54:06 INFO - 2015-11-27 03:54:06,451 DEBUG : BROWSER_OUTPUT: Number of tests: 14 03:54:06 INFO - 2015-11-27 03:54:06,451 DEBUG : BROWSER_OUTPUT: 03:54:06 INFO - 2015-11-27 03:54:06,451 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.00 Median:112.00 stddev:5.01 (4.5%) stddev-sans-first:5.26 03:54:06 INFO - 2015-11-27 03:54:06,451 DEBUG : BROWSER_OUTPUT: Values: 111.0 112.0 105.0 112.0 113.0 112.0 100.0 112.0 112.0 101.0 03:54:06 INFO - 2015-11-27 03:54:06,451 DEBUG : BROWSER_OUTPUT: 03:54:06 INFO - 2015-11-27 03:54:06,452 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:147.40 Median:153.00 stddev:14.95 (9.8%) stddev-sans-first:15.53 03:54:06 INFO - 2015-11-27 03:54:06,452 DEBUG : BROWSER_OUTPUT: Values: 156.0 131.0 158.0 170.0 132.0 148.0 150.0 135.0 165.0 129.0 03:54:06 INFO - 2015-11-27 03:54:06,452 DEBUG : BROWSER_OUTPUT: 03:54:06 INFO - 2015-11-27 03:54:06,452 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.40 Median:161.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 03:54:06 INFO - 2015-11-27 03:54:06,452 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 163.0 160.0 161.0 161.0 161.0 163.0 162.0 161.0 03:54:06 INFO - 2015-11-27 03:54:06,452 DEBUG : BROWSER_OUTPUT: 03:54:06 INFO - 2015-11-27 03:54:06,452 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:82.40 Median:89.00 stddev:10.23 (11.5%) stddev-sans-first:10.27 03:54:06 INFO - 2015-11-27 03:54:06,452 DEBUG : BROWSER_OUTPUT: Values: 73.0 96.0 87.0 91.0 72.0 76.0 72.0 91.0 94.0 72.0 03:54:06 INFO - 2015-11-27 03:54:06,452 DEBUG : BROWSER_OUTPUT: 03:54:06 INFO - 2015-11-27 03:54:06,452 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.80 Median:94.50 stddev:16.27 (17.2%) stddev-sans-first:16.86 03:54:06 INFO - 2015-11-27 03:54:06,452 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 128.0 94.0 94.0 95.0 130.0 94.0 96.0 127.0 03:54:06 INFO - 2015-11-27 03:54:06,452 DEBUG : BROWSER_OUTPUT: 03:54:06 INFO - 2015-11-27 03:54:06,452 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 03:54:06 INFO - 2015-11-27 03:54:06,452 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 109.0 110.0 110.0 110.0 111.0 109.0 109.0 109.0 03:54:06 INFO - 2015-11-27 03:54:06,452 DEBUG : BROWSER_OUTPUT: 03:54:06 INFO - 2015-11-27 03:54:06,452 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.70 Median:146.50 stddev:1.06 (0.7%) stddev-sans-first:1.09 03:54:06 INFO - 2015-11-27 03:54:06,453 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 146.0 146.0 147.0 148.0 146.0 146.0 149.0 147.0 03:54:06 INFO - 2015-11-27 03:54:06,453 DEBUG : BROWSER_OUTPUT: 03:54:06 INFO - 2015-11-27 03:54:06,453 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 03:54:06 INFO - 2015-11-27 03:54:06,453 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 03:54:06 INFO - 2015-11-27 03:54:06,453 DEBUG : BROWSER_OUTPUT: 03:54:06 INFO - 2015-11-27 03:54:06,453 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.10 Median:71.00 stddev:0.74 (1.0%) stddev-sans-first:0.71 03:54:06 INFO - 2015-11-27 03:54:06,453 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 71.0 70.0 71.0 71.0 72.0 72.0 71.0 70.0 03:54:06 INFO - 2015-11-27 03:54:06,453 DEBUG : BROWSER_OUTPUT: 03:54:06 INFO - 2015-11-27 03:54:06,453 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:69.00 stddev:0.94 (1.4%) stddev-sans-first:1.00 03:54:06 INFO - 2015-11-27 03:54:06,453 DEBUG : BROWSER_OUTPUT: Values: 69.0 68.0 68.0 69.0 70.0 68.0 69.0 71.0 69.0 69.0 03:54:06 INFO - 2015-11-27 03:54:06,453 DEBUG : BROWSER_OUTPUT: 03:54:06 INFO - 2015-11-27 03:54:06,453 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:84.00 stddev:1.03 (1.2%) stddev-sans-first:0.73 03:54:06 INFO - 2015-11-27 03:54:06,453 DEBUG : BROWSER_OUTPUT: Values: 82.0 84.0 86.0 84.0 84.0 84.0 85.0 84.0 85.0 84.0 03:54:06 INFO - 2015-11-27 03:54:06,453 DEBUG : BROWSER_OUTPUT: 03:54:06 INFO - 2015-11-27 03:54:06,453 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.60 Median:127.50 stddev:3.10 (2.4%) stddev-sans-first:3.24 03:54:06 INFO - 2015-11-27 03:54:06,454 DEBUG : BROWSER_OUTPUT: Values: 128.0 120.0 127.0 125.0 125.0 127.0 128.0 125.0 130.0 131.0 03:54:06 INFO - 2015-11-27 03:54:06,454 DEBUG : BROWSER_OUTPUT: 03:54:06 INFO - 2015-11-27 03:54:06,454 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.30 Median:148.50 stddev:8.65 (5.8%) stddev-sans-first:8.59 03:54:06 INFO - 2015-11-27 03:54:06,454 DEBUG : BROWSER_OUTPUT: Values: 154.0 136.0 149.0 145.0 148.0 134.0 151.0 160.0 140.0 136.0 03:54:06 INFO - 2015-11-27 03:54:06,454 DEBUG : BROWSER_OUTPUT: 03:54:06 INFO - 2015-11-27 03:54:06,454 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.50 stddev:1.34 (1.9%) stddev-sans-first:1.27 03:54:06 INFO - 2015-11-27 03:54:06,454 DEBUG : BROWSER_OUTPUT: Values: 67.0 70.0 67.0 69.0 70.0 69.0 70.0 68.0 70.0 67.0 03:54:06 INFO - 2015-11-27 03:54:06,454 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:54:06 INFO - 2015-11-27 03:54:06,454 DEBUG : BROWSER_OUTPUT: 03:54:07 INFO - 2015-11-27 03:54:07,369 INFO : Browser exited with error code: 0 03:54:07 INFO - 2015-11-27 03:54:07,423 INFO : Completed test kraken (00:01:00) 03:54:07 INFO - 2015-11-27 03:54:07,423 INFO : Starting test v8_7 03:54:07 INFO - 2015-11-27 03:54:07,423 DEBUG : operating with platform_type : linux_ 03:54:07 INFO - 2015-11-27 03:54:07,423 INFO : Initialising browser for v8_7 test... 03:54:07 INFO - 2015-11-27 03:54:07,429 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp16cSuV/profile http://localhost:37308/getInfo.html 03:54:11 INFO - 2015-11-27 03:54:11,233 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:54:11 INFO - 2015-11-27 03:54:11,233 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:54:11 INFO - 2015-11-27 03:54:11,233 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:54:11 INFO - 2015-11-27 03:54:11,233 DEBUG : BROWSER_OUTPUT: __metrics 03:54:11 INFO - 2015-11-27 03:54:11,381 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:54:12 INFO - 2015-11-27 03:54:12,648 INFO : Browser initialized. 03:54:12 INFO - 2015-11-27 03:54:12,649 INFO : Running cycle 1/1 for v8_7 test... 03:54:12 INFO - 2015-11-27 03:54:12,649 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp16cSuV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:54:24 INFO - 2015-11-27 03:54:24,491 DEBUG : BROWSER_OUTPUT: RSS: Main: 138752000 03:54:24 INFO - 2015-11-27 03:54:24,491 DEBUG : BROWSER_OUTPUT: 03:54:45 INFO - 2015-11-27 03:54:45,944 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37308/tests/v8_7/run.html (next: http://localhost:37308/tests/v8_7/run.html) 03:54:46 INFO - 2015-11-27 03:54:46,188 DEBUG : BROWSER_OUTPUT: RSS: Main: 435089408 03:54:46 INFO - 2015-11-27 03:54:46,188 DEBUG : BROWSER_OUTPUT: 03:54:46 INFO - 2015-11-27 03:54:46,189 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:54:46 INFO - 2015-11-27 03:54:46,189 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:54:46 INFO - 2015-11-27 03:54:46,190 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:54:46 INFO - 2015-11-27 03:54:46,190 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:54:46 INFO - 2015-11-27 03:54:46,190 DEBUG : BROWSER_OUTPUT: |0;Richards;165.50810989738497 03:54:46 INFO - 2015-11-27 03:54:46,190 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.53236336504384 03:54:46 INFO - 2015-11-27 03:54:46,190 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.31558513588465 03:54:46 INFO - 2015-11-27 03:54:46,190 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5133.333333333333 03:54:46 INFO - 2015-11-27 03:54:46,190 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2070.2479338842977 03:54:46 INFO - 2015-11-27 03:54:46,190 DEBUG : BROWSER_OUTPUT: |5;Earley;791.7656373713381 03:54:46 INFO - 2015-11-27 03:54:46,191 DEBUG : BROWSER_OUTPUT: |6;Boyer;12096.385542168675 03:54:46 INFO - 2015-11-27 03:54:46,191 DEBUG : BROWSER_OUTPUT: |7;RegExp;25717.94871794872 03:54:46 INFO - 2015-11-27 03:54:46,191 DEBUG : BROWSER_OUTPUT: |8;Splay;600.7130124777184 03:54:46 INFO - 2015-11-27 03:54:46,191 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 03:54:46 INFO - 2015-11-27 03:54:46,191 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:54:46 INFO - 2015-11-27 03:54:46,191 DEBUG : BROWSER_OUTPUT: __startTimestamp1448625286188__endTimestamp 03:54:46 INFO - 2015-11-27 03:54:46,192 DEBUG : BROWSER_OUTPUT: 03:54:46 INFO - 2015-11-27 03:54:46,192 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:54:46 INFO - 2015-11-27 03:54:46,192 DEBUG : BROWSER_OUTPUT: Number of tests: 10 03:54:46 INFO - 2015-11-27 03:54:46,192 DEBUG : BROWSER_OUTPUT: 03:54:46 INFO - 2015-11-27 03:54:46,193 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.51 Median:165.51 stddev:0.00 (0.0%) 03:54:46 INFO - 2015-11-27 03:54:46,193 DEBUG : BROWSER_OUTPUT: Values: 165.5 03:54:46 INFO - 2015-11-27 03:54:46,193 DEBUG : BROWSER_OUTPUT: 03:54:46 INFO - 2015-11-27 03:54:46,193 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.53 Median:186.53 stddev:0.00 (0.0%) 03:54:46 INFO - 2015-11-27 03:54:46,194 DEBUG : BROWSER_OUTPUT: Values: 186.5 03:54:46 INFO - 2015-11-27 03:54:46,194 DEBUG : BROWSER_OUTPUT: 03:54:46 INFO - 2015-11-27 03:54:46,194 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.32 Median:277.32 stddev:0.00 (0.0%) 03:54:46 INFO - 2015-11-27 03:54:46,194 DEBUG : BROWSER_OUTPUT: Values: 277.3 03:54:46 INFO - 2015-11-27 03:54:46,194 DEBUG : BROWSER_OUTPUT: 03:54:46 INFO - 2015-11-27 03:54:46,194 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5133.33 Median:5133.33 stddev:0.00 (0.0%) 03:54:46 INFO - 2015-11-27 03:54:46,194 DEBUG : BROWSER_OUTPUT: Values: 5133.3 03:54:46 INFO - 2015-11-27 03:54:46,194 DEBUG : BROWSER_OUTPUT: 03:54:46 INFO - 2015-11-27 03:54:46,194 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2070.25 Median:2070.25 stddev:0.00 (0.0%) 03:54:46 INFO - 2015-11-27 03:54:46,194 DEBUG : BROWSER_OUTPUT: Values: 2070.2 03:54:46 INFO - 2015-11-27 03:54:46,194 DEBUG : BROWSER_OUTPUT: 03:54:46 INFO - 2015-11-27 03:54:46,194 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:791.77 Median:791.77 stddev:0.00 (0.0%) 03:54:46 INFO - 2015-11-27 03:54:46,194 DEBUG : BROWSER_OUTPUT: Values: 791.8 03:54:46 INFO - 2015-11-27 03:54:46,194 DEBUG : BROWSER_OUTPUT: 03:54:46 INFO - 2015-11-27 03:54:46,194 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12096.39 Median:12096.39 stddev:0.00 (0.0%) 03:54:46 INFO - 2015-11-27 03:54:46,194 DEBUG : BROWSER_OUTPUT: Values: 12096.4 03:54:46 INFO - 2015-11-27 03:54:46,195 DEBUG : BROWSER_OUTPUT: 03:54:46 INFO - 2015-11-27 03:54:46,195 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25717.95 Median:25717.95 stddev:0.00 (0.0%) 03:54:46 INFO - 2015-11-27 03:54:46,195 DEBUG : BROWSER_OUTPUT: Values: 25717.9 03:54:46 INFO - 2015-11-27 03:54:46,195 DEBUG : BROWSER_OUTPUT: 03:54:46 INFO - 2015-11-27 03:54:46,195 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:600.71 Median:600.71 stddev:0.00 (0.0%) 03:54:46 INFO - 2015-11-27 03:54:46,195 DEBUG : BROWSER_OUTPUT: Values: 600.7 03:54:46 INFO - 2015-11-27 03:54:46,195 DEBUG : BROWSER_OUTPUT: 03:54:46 INFO - 2015-11-27 03:54:46,195 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 03:54:46 INFO - 2015-11-27 03:54:46,195 DEBUG : BROWSER_OUTPUT: Values: 4826.9 03:54:46 INFO - 2015-11-27 03:54:46,195 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:54:46 INFO - 2015-11-27 03:54:46,195 DEBUG : BROWSER_OUTPUT: 03:54:47 INFO - 2015-11-27 03:54:47,105 INFO : Browser exited with error code: 0 03:54:47 INFO - 2015-11-27 03:54:47,120 INFO : Completed test v8_7 (00:00:39) 03:54:47 INFO - 2015-11-27 03:54:47,171 INFO : Completed test suite (00:20:16) 03:54:47 INFO - 2015-11-27 03:54:47,171 DEBUG : Working with test: dromaeo_css 03:54:47 INFO - 2015-11-27 03:54:47,171 DEBUG : Generating results file: dromaeo_css 03:54:47 INFO - 2015-11-27 03:54:47,172 DEBUG : Working with test: kraken 03:54:47 INFO - 2015-11-27 03:54:47,173 DEBUG : Generating results file: kraken 03:54:47 INFO - 2015-11-27 03:54:47,173 INFO : javascript benchmark 03:54:47 INFO - 2015-11-27 03:54:47,173 DEBUG : Working with test: v8_7 03:54:47 INFO - 2015-11-27 03:54:47,173 DEBUG : Generating results file: v8_7 03:54:47 INFO - 2015-11-27 03:54:47,174 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:54:47 INFO - 2015-11-27 03:54:47,227 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,35]] 03:54:47 INFO - 2015-11-27 03:54:47,227 DEBUG : process_Request line: dromaeo_css 6288.51 graph.html#tests=[[72,94,35]] 03:54:47 INFO - 2015-11-27 03:54:47,227 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:54:47 INFO - 2015-11-27 03:54:47,256 DEBUG : process_Request line: kraken 1521.50 graph.html#tests=[[232,94,35]] 03:54:47 INFO - 2015-11-27 03:54:47,256 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:54:47 INFO - 2015-11-27 03:54:47,289 DEBUG : process_Request line: v8_7 19865.23 graph.html#tests=[[230,94,35]] 03:54:47 INFO - 2015-11-27 03:54:47,291 INFO : javascript benchmark 03:54:47 INFO - 2015-11-27 03:54:47,294 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2635.907743228987, 2736.986315068427, 2737.644106266185, 2738.6029025791267, 2755.586662000701, 4527.456705195373, 4645.117427688737, 4728.172569800284, 4736.550027747358, 4750.596199323058, 4671.976640116794, 4673.672842900998, 4726.361941137954, 4757.690750101241, 4793.7363445010515, 4367.148406060812, 4393.648508119343, 4414.713043652168, 4440.267355886291, 4453.732776033432, 4151.481064866892, 4459.977700111495, 4464.352668863013, 4505.549445055501, 4511.796969136397, 4256.276433006366, 4334.934975975363, 4336.609705126522, 4347.260965635849, 4353.346997950302, 4332.978335108336, 4361.563843615645, 4381.6494680425485, 4386.276264416368, 4436.64506839452, 4320.805563749607, 4332.91334173318, 4333.9133217335475, 4343.109662519176, 4374.737515749065, 4517.616002639779, 4626.976865115653, 4645.117427688729, 4655.7439340836245, 4668.323093151474, 5031.84904452867, 5034.194528875399, 5034.672746271481, 5036.899262014739, 5039.118154322979, 5002.499750024968, 5071.414712774063, 5107.0, 5112.565431938289, 5117.923231151536, 4728.4798672146035, 4729.7398643074275, 4749.4775574686755, 4765.571098601108, 4768.47546769855, 4968.205087186033, 5215.973920130375, 5220.504052115043, 5220.530152286313, 5223.268742376071, 4894.339264199288, 4913.115639184981, 4914.311996320518, 4918.729469879191, 4919.114559379274, 5067.113255180328, 5106.387233531926, 5108.948910510921, 5135.435102138762, 5140.460251673595, 5036.622253331015, 5039.874003149951, 5042.470540593258, 5046.873828154326, 5083.745812709423, 4790.353302304214, 4912.975435122801, 5003.924941125886, 5012.097822392005, 5052.242163675478, 4178.456800615901, 4250.468691413574, 4252.893677658083, 4284.100338928797, 4295.656347492193, 3762.774233545996, 3764.7741135531955, 3773.3773927301686, 3794.886153415402, 3805.353089974711, 4191.685623578243, 4307.181635489247, 4378.343248512685, 4378.43080399546, 4424.778761061934, 4972.5276098770555, 5048.29323894655, 5064.417591976896, 5073.086844367976, 5123.487651234846, 4359.934600980988, 4391.8462853799965, 4392.758398288125, 4394.494633117232, 4437.866863994085, 4408.757518336458, 4523.7285762854335, 4594.678372513892, 4602.033572949651, 4636.235021221461, 4691.601213896789, 4757.381540399864, 4771.594414474808, 4785.59322457595, 4815.15734746411, 5114.539691427789, 5155.767990440364, 5159.277701121921, 5164.277001219907, 5206.401263854554, 4675.462321832897, 4812.711237325771, 4867.58625516835, 4879.804807807648, 4922.015596880567, 4929.580985616263, 4942.802287908444, 5004.799808007639, 5022.372203474566, 5033.723145226902, 5104.081265372269, 5108.412532558655, 5116.6418350716585, 5120.8719782004255, 5160.09698302788, 4766.11826812027, 4894.975525122351, 4934.383202099738, 4941.678790878582, 4948.257761335684, 4880.1215781159735, 4898.730569818694, 4925.605951523941, 4928.901421971612, 4961.7519124044375, 4848.9757551212015, 4870.366852309177, 4875.293082503088, 4914.410270767531, 4921.237208232729, 4706.858794236178, 4989.077020751172, 4989.950100499093, 5008.749562521933, 5047.722375269395, 4719.811207551659, 4795.448523419851, 4821.228603423436, 4837.612990960644, 4838.056578967067], "unit": "ms", "name": "dojo.html", "value": 4648.885579189182}, {"lowerIsBetter": false, "replicates": [573.8077743955777, 575.315374704102, 576.9653820770751, 580.2427831679659, 580.3239226301358, 28544.857275713617, 29027.0, 29158.12525624232, 36401.27197456049, 37681.434778478346, 39826.0, 40410.59589404105, 40482.190356192856, 40612.39081413781, 40650.796746016305, 8059.355251579889, 8227.095019547845, 8233.259006689397, 8234.464759790595, 8236.011678598546, 7191.604461754601, 7381.372583330423, 10308.020738029913, 10613.097886679603, 10614.469276536181, 10269.794604107914, 10361.274710770249, 10396.272260941738, 10404.0, 10416.166706663449, 6457.741690332381, 6585.6707164641575, 10184.847227291597, 10322.535485903152, 10324.328918620304, 10301.587936482532, 10613.787724245549, 10624.36253824773, 10643.0, 10648.893511064867, 37160.81419592912, 37542.62457375446, 37623.24753504942, 37679.24641507182, 37718.811405943066, 2944.3669611033515, 2944.690807465207, 3017.637883453978, 3408.897733068012, 3604.6395360464007, 28333.716662833314, 28538.143855684364, 28667.56998645022, 28850.711492885013, 28985.275368115756, 3417.538632284635, 3442.122258824009, 3454.7408944329277, 3529.294141171776, 3559.7864128152137, 221528.0, 221698.0, 223342.0, 223378.0, 224541.0, 48527.57362131879, 49708.75145624321, 53775.0, 54160.18759718607, 54246.45753542493, 64592.0, 65525.34474655288, 65624.01563976544, 65680.0, 66043.0, 12769.553065642658, 12975.156614820195, 13039.0, 13054.412551435209, 13054.934725326313, 8847.955760221286, 8924.910750892537, 8935.776605584912, 8941.061188575106, 8947.32895032875, 18200.726989095176, 18359.90820045918, 18370.632587348176, 18412.26350945947, 18455.81544184568, 7220.530665506725, 7539.396848252127, 7595.088589369311, 7635.885461718079, 7725.150233474314, 803.9035315762146, 810.7567729681072, 865.8225063861893, 929.0430856218106, 967.6468089147411, 26091.792501080196, 26239.73760262373, 26269.949202031705, 26367.472650546883, 26601.866990664923, 962.4658314635444, 979.4857699707568, 1028.0901402259055, 1056.8784589772274, 1082.756379814551, 13651.180929144084, 13879.0, 14006.929965350108, 14019.50931717385, 14107.435702571987, 256920.0, 261112.0, 261599.0, 261931.0, 262573.0, 37906.43140352897, 45899.541004590195, 46092.3086153708, 46254.5243665887, 46261.30608040882, 1056.799208150449, 1082.924195306321, 1175.3887978251432, 1195.0559058343986, 1195.9521619135312, 24490.87754561216, 25793.226203213933, 27054.45891082128, 27190.0, 28942.13173604795, 36350.63649363472, 37196.25607487889, 37261.62738372581, 42432.78783606062, 42843.78578107214, 315093.0, 322923.0, 325103.0, 325407.0, 325678.0, 27447.588286176124, 27773.44453110886, 27776.305592360353, 27887.0, 27966.16101516958, 38959.415608765325, 39737.40393894152, 39928.40107398333, 39940.2011959765, 40195.3970690434, 31698.524522131724, 33172.83413583013, 33577.0, 33723.83138084294, 33845.492317615746, 30167.396652067273, 30414.239644009078, 30508.154711059055, 30805.38389232158, 30942.38115237728, 30949.0715278542, 31015.844920775253, 31112.066638000895, 31227.53158702576, 31291.530627040156, 28070.578941316304, 28342.0, 31411.0, 32914.153663796096, 33066.17334566655, 23213.651795222748, 23343.41081429337, 23510.882445587664, 23519.647205291592, 23680.407989799704], "unit": "ms", "name": "ext.html", "value": 17188.542232982054}, {"lowerIsBetter": false, "replicates": [313.8964141833195, 314.48424583682777, 315.79631137916044, 319.9008307424698, 322.5468217154897, 12411.503539858395, 12798.36008199591, 13769.655758606028, 14604.926975365122, 14988.325525351358, 12304.692382690437, 14154.43382264708, 15302.23488825557, 16022.118783466905, 16075.919620401912, 4838.371011768465, 4841.443234028096, 4844.442889067749, 4888.87777805555, 5014.2227954666905, 3493.8253087345656, 3600.6759391654746, 4942.777575009115, 4977.601791856643, 5527.336719593654, 5703.5152012079025, 5710.714464276791, 5727.713614319288, 5728.0, 5732.197492351053, 5672.092465205568, 6111.724972376253, 6286.182796236483, 6289.056641503811, 6302.4958003359625, 5937.168796368512, 6055.666938318391, 6057.939420605781, 6063.0, 6190.690465476709, 21661.67507487389, 21722.78277217239, 21829.126834926585, 22151.0, 22264.332070037926, 1855.8329750322537, 1872.4663470910862, 1916.3005502991448, 1925.5956249187686, 1984.2063174730079, 13792.448302067905, 13929.512467063603, 13988.93005534976, 14296.499622513265, 14395.136291822419, 1811.8356022712571, 1876.3245231716571, 1883.3314173468495, 1943.057617055741, 1960.9117589708496, 49520.25719614208, 50493.0, 51023.234651480256, 60193.056899675015, 63836.3616363835, 15451.922740386452, 15477.22613869302, 15495.147766872704, 15515.224238788016, 15523.990940588825, 23045.53908921846, 23113.76886231116, 23291.06835726586, 23342.64986025211, 23376.415589610395, 8237.50574965504, 8243.876341854877, 8280.254777069973, 8284.295834853985, 8322.54226017575, 6648.0, 6900.03399524067, 6912.930870691329, 6918.481113916477, 6932.549384290005, 7586.544807311579, 7590.430717696195, 7590.533076750078, 7603.239676032353, 7610.9238907611325, 1538.8922775405615, 1630.8613767829868, 1644.6792875389185, 2142.1762154554044, 2888.4367548328296, 307.90762771169005, 310.86011294917375, 328.9325688233906, 761.5963539324167, 906.8186362727481, 8916.331275154389, 9279.860802087975, 9346.53267336644, 15150.393984240507, 15594.376224951102, 817.284875733733, 829.2536716954669, 830.6511265268601, 851.936104792143, 936.1387523478417, 8509.10654381281, 8631.395802293779, 8702.521361325187, 8820.382573219813, 8870.246029087471, 432917.0, 506144.0, 511796.0, 512270.0, 519039.0, 71380.0, 71436.64281678663, 73154.63422682852, 74789.62605186939, 75846.24153758503, 1045.8378951262414, 1048.9527971241312, 1055.4406164732704, 1055.4458909072798, 1073.8013467508536, 13580.93209533946, 14337.498187563386, 14374.784378234544, 14423.567292981228, 14440.711185776436, 30416.391672166876, 30579.847100765244, 30923.226919327197, 31514.842425787723, 31731.524027140073, 40774.388384174854, 40903.795481022404, 42226.788866055475, 42785.57214427816, 44635.0, 7925.28672419485, 8134.83730325402, 8165.469244499089, 8227.794305142419, 8238.134995825352, 9344.0, 9357.625694972125, 9422.858657120285, 9485.288603354638, 13561.0, 13655.385507651981, 13683.589492315246, 13829.446822127406, 13997.160170389809, 14055.086419382707, 12904.0, 13245.933770331087, 13320.400581973641, 13513.662158446117, 13905.0, 13346.466141354236, 13363.465461381436, 13587.728245435233, 13775.38010789497, 13934.0, 8099.959500202697, 8105.594720263845, 8151.5109093454585, 8532.829343412974, 8544.57277136153, 8546.0, 10303.433311167957, 12862.228266303677, 13851.653708657364, 13991.650208744863], "unit": "ms", "name": "jquery.html", "value": 8568.19647703388}, {"lowerIsBetter": false, "replicates": [1188.6612315490088, 1354.3769865861702, 1389.0485017762833, 1598.0811033655648, 1675.958101047474, 5678.914816277754, 6373.904391434126, 6714.194296684393, 6719.0257412675255, 6724.193096828375, 6611.636360000198, 6612.404883560479, 6681.265060843303, 6688.732450701966, 6690.565113267634, 1668.8414600612923, 1705.8123606403285, 1927.4892153579349, 1967.6359873423391, 1967.803219678035, 1960.5980773941308, 2011.3563659628924, 2014.53665656899, 2015.5465020370445, 2016.9294074707389, 1906.4376009077287, 1927.8361339286178, 1929.8649094563386, 1962.4014675523958, 1963.5385684364162, 1966.2528239269059, 1976.10087410228, 2007.985967086612, 2012.9194832206622, 2014.9899250503727, 1998.7701414337391, 2011.7686466056446, 2015.2745011795741, 2018.3743039657606, 2022.7269318641943, 6594.1427614410295, 6611.239707433659, 6663.566868153554, 6664.233613134503, 6667.6666166691475, 3672.210474747915, 3745.0637340664834, 3764.7741135531683, 3779.829907654162, 3780.546334439857, 2509.2848538166536, 2560.167945417728, 2601.609758536216, 2607.5436798560177, 2627.7240889706495, 767.382257282887, 841.4320333774739, 901.6123067081153, 921.5760750054983, 921.663592788634, 8557.786055348604, 8660.8700869487, 8719.564021798884, 8721.825563488757, 8743.300535957109, 3438.449848024304, 3492.371373152806, 3505.2288496530723, 3505.8948231553095, 3522.5949015862993, 7609.847803044019, 7616.581088040211, 7660.578668173192, 7671.808204794925, 7675.117361503387, 3824.4263360495593, 3832.789196594214, 3843.1160833008566, 3844.038990252437, 3863.6715879150024, 3492.89521314361, 3506.859725610947, 3510.1575621851084, 3512.2624248907505, 3517.7009954153673, 3177.1421716136515, 3182.5226216067776, 3183.0291761013114, 3189.186757376854, 3210.06907996683, 966.5602151021268, 966.8598053282235, 970.3838062830154, 972.1445128287062, 973.868527748759, 1112.5939032253332, 1143.2511704833348, 1150.7295785490403, 1176.858776946772, 1176.9882301176879, 6095.329513753483, 6114.633122012693, 6168.568200225941, 6170.321264660884, 6194.0708893665405, 1066.7706443114769, 1096.4901320885667, 1108.933463992163, 1111.0778054215143, 1118.3457677258732, 4985.551300382983, 4991.176455884738, 5033.672811267256, 5033.874153146201, 5040.697558146523, 6673.265940746514, 7257.310555497219, 7461.888071678929, 7517.924820751832, 7602.277783610548, 6624.403803657694, 7576.3181313682035, 7667.0416197975255, 7747.225277472207, 7766.106897706836, 5949.851253718692, 6037.818865434044, 6044.0, 6064.332923378425, 6066.75732970685, 6086.878262434815, 6135.509159267159, 6152.723127459186, 6162.352952939877, 6215.844603884939, 6804.931950680628, 6884.0, 6884.827879303058, 6892.276930767308, 6918.930810691829, 6889.069975553236, 7015.894761578478, 7040.788776336718, 7041.084658994298, 7056.576605403692, 5876.559258055749, 5934.3175534814045, 5978.641281523122, 5978.940210597838, 5999.640021598718, 6268.153799237045, 6270.0, 6282.089097080806, 6294.402031806971, 6296.590721603081, 5819.5053420459735, 5903.203067585992, 5910.261217347832, 6008.218931538872, 6012.128241404885, 6072.05883088122, 6105.8168254952425, 6164.106204600397, 6184.783532576338, 6226.470749986302, 5924.607717186372, 5951.702414879325, 5953.583249172516, 5971.402859713994, 5984.042553191469, 5490.176473529003, 5540.806071787468, 5550.222968784293, 5570.721463926707, 5592.496675299242, 5534.1975413564005, 5545.667259964415, 5562.888742225052, 5576.414476479911, 5587.916181257366], "unit": "ms", "name": "mootools.html", "value": 3822.8814442094804}, {"lowerIsBetter": false, "replicates": [285.5032243895622, 290.03274080940065, 290.26273265904604, 291.82636331382827, 299.40119760479047, 5034.572061374778, 5363.195520671901, 5451.100568406218, 5458.6724796512135, 5470.343558772943, 5026.623003274751, 5154.819581314655, 5183.637145399824, 5361.088614935461, 5367.409584945653, 4120.773357465338, 4137.544870064298, 4138.751674899516, 4139.7309174903685, 4142.233686767958, 3913.921721565567, 4135.875923722293, 4135.979320103395, 4141.958580414187, 4144.730592511477, 3956.248312820555, 3996.9200615987806, 4004.659603933669, 4048.1701251243426, 4115.012397024708, 4085.2850751118585, 4087.264292427362, 4091.85678501251, 4098.549159592442, 4105.486814148247, 3559.199180184464, 3566.4293713006055, 3571.482135090397, 3572.089117275078, 3573.4282514797505, 5072.188449848043, 5079.3650793650795, 5084.593232541388, 5094.592432605383, 5096.9490305097215, 4650.0932318197965, 4723.527647235283, 4800.279958006292, 4807.471178170398, 4819.614430845524, 5664.54683625309, 5674.319081710221, 5675.34733505648, 5681.602287839853, 5684.715764211773, 3988.0827409695644, 3994.7603143811466, 3995.1011022519992, 3999.14018486024, 4003.679705623543, 5945.375735547748, 5973.701314934236, 5976.8505787355225, 5981.850453738648, 5981.8803623927715, 4017.5982401760175, 4110.609492098246, 4117.0, 4123.525794533607, 4136.324788460678, 4173.791310434527, 4185.016521117535, 4185.790710464465, 4190.371444283382, 4190.497140343178, 4766.308885211694, 4768.499307572724, 4773.856784296477, 4777.378940737752, 4779.402574678165, 5661.150827375926, 5670.8015219467125, 5676.4323567642905, 5684.8010319638615, 5686.60193786431, 1439.992800035993, 1449.3043339197245, 1482.792409062732, 1483.8738707209793, 1484.5843163914121, 994.4431118573622, 1003.2626019875386, 1010.2927950434726, 1024.2522958240527, 1029.6190409548515, 4981.053599816023, 4995.275685025651, 4995.600351971833, 4997.25041243809, 4997.625178111583, 5898.8230353089475, 5900.203472531153, 5902.498287645512, 5904.0, 5908.143319218775, 4824.49342819006, 4916.704997700078, 4967.5529202371235, 4987.0524600325825, 4992.552159873669, 3176.6029246344206, 3203.6636153204045, 3209.9679003210135, 3211.1811488070393, 3218.291975765328, 5618.073017952074, 5618.241537392481, 5619.325680918234, 5625.915611265835, 5627.324721033502, 5967.224260846149, 6098.939010609926, 6108.602940808833, 6108.877822443526, 6111.0, 5621.100623900156, 5634.183043458757, 5637.182608521824, 5640.605157639008, 5643.097104463348, 5951.166836642787, 5953.464188222907, 5957.672328022, 5958.940410596012, 5960.701964901651, 5761.39505351932, 5800.651960882361, 5808.30300363959, 5814.592978491465, 5818.214541037075, 5487.396386397573, 5630.549556035426, 5631.070873306023, 5635.239242702182, 5635.464630860061, 4123.711340206157, 4133.731307465006, 4135.524414692349, 4136.31750761121, 4140.047789008485, 5939.851503712269, 5943.821685349447, 5947.31605865331, 5947.940520594739, 5958.821235362946, 5617.747201375866, 5689.34572524165, 5721.199032135588, 5733.397993210653, 5733.8566535836935, 5710.114932185518, 5714.885702285847, 5715.428457154251, 5724.942750572441, 5731.684757338387, 5604.271444712162, 5608.9158662619275, 5610.410906854721, 5611.9337325907945, 5618.016847051668, 5747.396523364986, 5747.453991870766, 5755.884882302415, 5756.568257380797, 5761.251037365116, 5423.647462914898, 5606.971965140311, 5616.0, 5619.466150715675, 5626.85932851682], "unit": "ms", "name": "prototype.html", "value": 4261.769369996465}, {"lowerIsBetter": false, "replicates": [672.8250654829743, 682.8122266376749, 776.6194564663315, 789.5578476053411, 791.9841603167937, 10818.242723009393, 10947.397893115876, 10951.561937522489, 10969.0, 11013.063889569386, 10669.679909602704, 10754.569817207303, 10784.78430431391, 10788.784224315528, 10853.565857365697, 597.4622839444502, 613.5613036678774, 614.0819474885053, 756.4704706705301, 775.9418043646721, 771.1786946901532, 771.5717776633966, 778.5756762564388, 779.0, 779.4660657449665, 764.7591008832228, 773.288574511448, 773.8684423647965, 774.4075782026754, 775.4726785785664, 619.63441569474, 630.8864404407228, 777.5956502618664, 792.4809249941297, 795.2723258218723, 597.8744463662636, 598.6198763785028, 598.6647477412663, 598.7634884220752, 598.7664810723821, 10350.844737328945, 10402.0, 10412.42731649759, 10419.79160416795, 10435.895641043568, 10639.468026598717, 11520.94239528797, 11544.769104617944, 11814.17300788945, 11822.763544729143, 9023.458592484407, 9099.81800363989, 9112.407693499901, 9112.544372781334, 9113.362064655477, 3219.7746157768966, 3220.677932206784, 3252.593425821772, 3256.446404111307, 3297.241634424072, 40244.59755402467, 40333.0, 40354.596454035374, 40403.191936161405, 40484.59515404838, 9562.61749530025, 9789.608415663437, 9809.509524523744, 9916.702498925044, 9936.751581210528, 16889.155542223085, 17016.57458563521, 17020.14899255057, 17022.744658830128, 17028.659426811642, 5983.252093488314, 6045.33501314855, 6149.600275982047, 6153.876922461615, 6168.1056246843955, 3456.1705190754037, 3518.3029362307634, 3543.5039094526787, 3565.286942611488, 3628.63713628635, 2641.881115349814, 2657.4286528396487, 2676.0901293560282, 2685.5971604259125, 2689.1529168311918, 468.8851231448249, 471.4460508902026, 476.58775159486794, 480.9879753006203, 483.1134867518144, 574.4600075928614, 575.8877018981259, 580.7676929228343, 595.8986972214734, 606.8088552106072, 6832.829179270459, 7221.350078492856, 7296.489245752852, 8153.02163740355, 8311.210435008665, 483.7339463295174, 541.9647722898, 545.4218528359951, 592.7125344208056, 639.9161284579659, 3511.122219445139, 3693.1874987502706, 3739.607341229186, 3787.1857550626746, 3848.9807550962064, 49414.25878611824, 51012.74493627508, 51069.74465127725, 51316.48683513192, 51342.74328628408, 45109.097818043454, 45134.77432612816, 45697.54302457, 46018.76990615026, 46206.0, 42988.57011429908, 43591.0, 43886.78056609697, 44043.33934990978, 44133.33799993002, 7060.0, 7077.469189810682, 7110.4537468109675, 7271.8909216360735, 7312.561246325237, 30736.38527229398, 31093.222669433446, 31770.523442147925, 32087.83956080298, 32447.0, 36404.635953641184, 36606.63393366139, 37598.248035039695, 41187.794061029505, 41230.79384603058, 8934.910650893667, 9197.448153110834, 9261.53692315395, 9322.813543729224, 9409.48247846375, 10205.691883978741, 10214.591416343263, 10253.948730256301, 10532.736681583021, 10607.151427885905, 9370.625174992923, 9610.0, 9646.855297170408, 9699.6120155193, 9891.752706182404, 9396.812063758824, 9419.246460283299, 9485.430874147572, 9547.0, 9656.468894210886, 9802.215822734306, 9889.456079915673, 9923.702288931343, 10213.285070045025, 10476.738081548023, 8927.776805579913, 9038.697390593341, 9300.488473134043, 9497.192738617296, 9553.092456216647, 8605.569721513773, 8728.91271087281, 8903.0, 8919.821603568022, 9245.214156796748], "unit": "ms", "name": "yui.html", "value": 5543.462970726857}], "name": "dromaeo_css", "value": 6288.513739115174}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 112.0, 105.0, 112.0, 113.0, 112.0, 100.0, 112.0, 112.0, 101.0], "unit": "ms", "name": "ai-astar", "value": 109.0}, {"lowerIsBetter": true, "replicates": [156.0, 131.0, 158.0, 170.0, 132.0, 148.0, 150.0, 135.0, 165.0, 129.0], "unit": "ms", "name": "audio-beat-detection", "value": 147.4}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 163.0, 160.0, 161.0, 161.0, 161.0, 163.0, 162.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [73.0, 96.0, 87.0, 91.0, 72.0, 76.0, 72.0, 91.0, 94.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 82.4}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 128.0, 94.0, 94.0, 95.0, 130.0, 94.0, 96.0, 127.0], "unit": "ms", "name": "audio-oscillator", "value": 104.8}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 110.0, 110.0, 110.0, 111.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 147.0, 148.0, 146.0, 146.0, 149.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 71.0, 70.0, 71.0, 71.0, 72.0, 72.0, 71.0, 70.0], "unit": "ms", "name": "json-parse-financial", "value": 71.1}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 68.0, 69.0, 70.0, 68.0, 69.0, 71.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.0}, {"lowerIsBetter": true, "replicates": [82.0, 84.0, 86.0, 84.0, 84.0, 84.0, 85.0, 84.0, 85.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.2}, {"lowerIsBetter": true, "replicates": [128.0, 120.0, 127.0, 125.0, 125.0, 127.0, 128.0, 125.0, 130.0, 131.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 126.6}, {"lowerIsBetter": true, "replicates": [154.0, 136.0, 149.0, 145.0, 148.0, 134.0, 151.0, 160.0, 140.0, 136.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.3}, {"lowerIsBetter": true, "replicates": [67.0, 70.0, 67.0, 69.0, 70.0, 69.0, 70.0, 68.0, 70.0, 67.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.7}], "name": "kraken", "value": 1521.4999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.50810989738497], "unit": "score", "name": "Richards", "value": 213.294684}, {"lowerIsBetter": false, "replicates": [186.53236336504384], "unit": "score", "name": "DeltaBlue", "value": 354.4585980000001}, {"lowerIsBetter": false, "replicates": [277.31558513588465], "unit": "score", "name": "Encrypt", "value": 959.8486860000002}, {"lowerIsBetter": false, "replicates": [5133.333333333333], "unit": "score", "name": "Decrypt", "value": 51.85344155844158}, {"lowerIsBetter": false, "replicates": [2070.2479338842977], "unit": "score", "name": "RayTrace", "value": 357.4397964071858}, {"lowerIsBetter": false, "replicates": [791.7656373713381], "unit": "score", "name": "Earley", "value": 841.7427690000002}, {"lowerIsBetter": false, "replicates": [12096.385542168675], "unit": "score", "name": "Boyer", "value": 55.096044820717125}, {"lowerIsBetter": false, "replicates": [25717.94871794872], "unit": "score", "name": "RegExp", "value": 35.42214855433696}, {"lowerIsBetter": false, "replicates": [600.7130124777184], "unit": "score", "name": "Splay", "value": 135.65712462908007}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 19865.233177367845}]} 03:54:47 INFO - RETURN: dromaeo_css: 6288.51 03:54:47 INFO - RETURN: kraken: 1521.50 03:54:47 INFO - RETURN: v8_7: 19865.23 03:54:47 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,35]]", "result": "19865.23"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,35]]", "result": "1521.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,35]]", "result": "6288.51"}}} 03:54:47 INFO - Return code: 0 03:54:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:54:47 INFO - # TBPL SUCCESS # 03:54:47 INFO - Running post-action listener: _resource_record_post_action 03:54:47 INFO - Running post-run listener: _resource_record_post_run 03:54:48 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 4096; Write bytes: 516341760; Read time: 8; Write time: 470528 03:54:48 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 240746496; Read time: 0; Write time: 339556 03:54:48 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 4096; Write bytes: 275595264; Read time: 8; Write time: 130972 03:54:48 INFO - Running post-run listener: _upload_blobber_files 03:54:48 INFO - Blob upload gear active. 03:54:48 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 03:54:48 INFO - Copying logs to upload dir... 03:54:48 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1270.000516 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2015-11-27 03:54:48.354789) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-27 03:54:48.360784) ========= 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=f5f5a079460e1a9be8676904000001c1-1448623641.758232-1609909953 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/XzM3swrvSAeNyTVpz58pgw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009960 build_url: 'https://queue.taskcluster.net/v1/task/XzM3swrvSAeNyTVpz58pgw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-27 03:54:48.415224) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 03:54:48.416058) ========= 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=f5f5a079460e1a9be8676904000001c1-1448623641.758232-1609909953 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004548 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 03:54:48.471332) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-27 03:54:48.472068) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-27 03:54:48.472716) ========= ========= Total master_lag: 0.32 =========