builder: cedar_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-027 starttime: 1449147518.1 results: success (0) buildid: 20151203034831 builduid: f3ee83fe477340ec909bd76742a75f86 revision: fcd9df15e93764277b014019a473d5d1bccd810e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-03 04:58:38.104034) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-03 04:58:38.105187) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-03 04:58:38.105506) ========= 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=447a3abc0420b6a47dd38cba000001bf-1449146963.112510-1882458026 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006577 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-03 04:58:38.131502) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-03 04:58:38.131885) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-03 04:58:38.151071) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 04:58:38.151393) ========= 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=447a3abc0420b6a47dd38cba000001bf-1449146963.112510-1882458026 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004657 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 04:58:38.205402) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-03 04:58:38.205697) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-03 04:58:38.206102) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 04:58:38.206373) ========= 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=447a3abc0420b6a47dd38cba000001bf-1449146963.112510-1882458026 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-03 04:58:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.8M=0s 2015-12-03 04:58:38 (40.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.111041 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 04:58:38.333590) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 04:58:38.333929) ========= 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=447a3abc0420b6a47dd38cba000001bf-1449146963.112510-1882458026 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017854 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 04:58:38.388860) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 04:58:38.389245) ========= bash -c 'python archiver_client.py mozharness --repo projects/cedar --rev fcd9df15e93764277b014019a473d5d1bccd810e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/cedar --rev fcd9df15e93764277b014019a473d5d1bccd810e --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=447a3abc0420b6a47dd38cba000001bf-1449146963.112510-1882458026 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-03 04:58:38,699 truncating revision to first 12 chars 2015-12-03 04:58:38,699 Setting DEBUG logging. 2015-12-03 04:58:38,699 attempt 1/10 2015-12-03 04:58:38,699 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/cedar/fcd9df15e937?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-03 04:58:38,948 unpacking tar archive at: cedar-fcd9df15e937/testing/mozharness/ program finished with exit code 0 elapsedTime=0.569795 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 04:58:38.976483) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-03 04:58:38.976843) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-03 04:58:38.988611) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-03 04:58:38.989251) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/default ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-03 04:58:38.989908) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-12-03 04:58:38.990657) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Cedar --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 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', 'Cedar', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Cedar'] 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=447a3abc0420b6a47dd38cba000001bf-1449146963.112510-1882458026 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:58:39 INFO - MultiFileLogger online at 20151203 04:58:39 in /builds/slave/test 04:58:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Cedar --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 04:58:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:58:39 INFO - {'append_to_log': False, 04:58:39 INFO - 'base_work_dir': '/builds/slave/test', 04:58:39 INFO - 'blob_upload_branch': 'Cedar', 04:58:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:58:39 INFO - 'branch': 'Cedar', 04:58:39 INFO - 'buildbot_json_path': 'buildprops.json', 04:58:39 INFO - 'config_files': ('talos/linux_config.py',), 04:58:39 INFO - 'default_actions': ('clobber', 04:58:39 INFO - 'read-buildbot-config', 04:58:39 INFO - 'download-and-extract', 04:58:39 INFO - 'populate-webroot', 04:58:39 INFO - 'create-virtualenv', 04:58:39 INFO - 'install', 04:58:39 INFO - 'run-tests'), 04:58:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:58:39 INFO - 'download_minidump_stackwalk': True, 04:58:39 INFO - 'download_symbols': 'ondemand', 04:58:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:58:39 INFO - 'tooltool.py': '/tools/tooltool.py', 04:58:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:58:39 INFO - '/tools/misc-python/virtualenv.py')}, 04:58:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:58:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:58:39 INFO - 'installer_path': 'installer.exe', 04:58:39 INFO - 'log_level': 'info', 04:58:39 INFO - 'log_name': 'talos', 04:58:39 INFO - 'log_to_console': True, 04:58:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:58:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:58:39 INFO - 'opt_config_files': (), 04:58:39 INFO - 'pip_index': False, 04:58:39 INFO - 'sps_profile': False, 04:58:39 INFO - 'sps_profile_interval': 0, 04:58:39 INFO - 'suite': 'dromaeojs', 04:58:39 INFO - 'system_bits': '64', 04:58:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:58:39 INFO - 'title': 'talos-linux64-ix-027', 04:58:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:58:39 INFO - 'use_talos_json': True, 04:58:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:58:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:58:39 INFO - 'work_dir': 'build'} 04:58:39 INFO - ##### 04:58:39 INFO - ##### Running clobber step. 04:58:39 INFO - ##### 04:58:39 INFO - Running pre-action listener: _resource_record_pre_action 04:58:39 INFO - Running main action method: clobber 04:58:39 INFO - rmtree: /builds/slave/test/build 04:58:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:58:39 INFO - Running post-action listener: _resource_record_post_action 04:58:39 INFO - ##### 04:58:39 INFO - ##### Running read-buildbot-config step. 04:58:39 INFO - ##### 04:58:39 INFO - Running pre-action listener: _resource_record_pre_action 04:58:39 INFO - Running main action method: read_buildbot_config 04:58:39 INFO - Using buildbot properties: 04:58:39 INFO - { 04:58:39 INFO - "properties": { 04:58:39 INFO - "buildnumber": 3, 04:58:39 INFO - "product": "firefox", 04:58:39 INFO - "script_repo_revision": "default", 04:58:39 INFO - "builddir": "cedar_ubuntu64_hw_test-dromaeojs", 04:58:39 INFO - "repository": "", 04:58:39 INFO - "buildername": "Ubuntu HW 12.04 x64 cedar talos dromaeojs", 04:58:39 INFO - "buildid": "20151203034831", 04:58:39 INFO - "slavename": "talos-linux64-ix-027", 04:58:39 INFO - "pgo_build": "False", 04:58:39 INFO - "basedir": "/builds/slave/test", 04:58:39 INFO - "project": "", 04:58:39 INFO - "platform": "ubuntu64_hw", 04:58:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:58:39 INFO - "slavebuilddir": "test", 04:58:39 INFO - "scheduler": "tests-cedar-linux64-talos", 04:58:39 INFO - "branch": "cedar", 04:58:39 INFO - "repo_path": "projects/cedar", 04:58:39 INFO - "stage_platform": "linux64", 04:58:39 INFO - "builduid": "f3ee83fe477340ec909bd76742a75f86", 04:58:39 INFO - "revision": "fcd9df15e93764277b014019a473d5d1bccd810e" 04:58:39 INFO - }, 04:58:39 INFO - "sourcestamp": { 04:58:39 INFO - "repository": "", 04:58:39 INFO - "hasPatch": false, 04:58:39 INFO - "project": "", 04:58:39 INFO - "branch": "cedar-linux64-talos", 04:58:39 INFO - "changes": [ 04:58:39 INFO - { 04:58:39 INFO - "category": null, 04:58:39 INFO - "files": [ 04:58:39 INFO - { 04:58:39 INFO - "url": null, 04:58:39 INFO - "name": "https://queue.taskcluster.net/v1/task/aGbSBdUXQ0OioxgcVpHllg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 04:58:39 INFO - } 04:58:39 INFO - ], 04:58:39 INFO - "repository": "", 04:58:39 INFO - "rev": "fcd9df15e93764277b014019a473d5d1bccd810e", 04:58:39 INFO - "who": "dminor@mozilla.com", 04:58:39 INFO - "when": 1449147508, 04:58:39 INFO - "number": 6738950, 04:58:39 INFO - "comments": "merge m-c -> cedar", 04:58:39 INFO - "project": "", 04:58:39 INFO - "at": "Thu 03 Dec 2015 04:58:28", 04:58:39 INFO - "branch": "cedar-linux64-talos", 04:58:39 INFO - "revlink": "", 04:58:39 INFO - "properties": [ 04:58:39 INFO - [ 04:58:39 INFO - "buildid", 04:58:39 INFO - "20151203034831", 04:58:39 INFO - "Change" 04:58:39 INFO - ], 04:58:39 INFO - [ 04:58:39 INFO - "builduid", 04:58:39 INFO - "f3ee83fe477340ec909bd76742a75f86", 04:58:39 INFO - "Change" 04:58:39 INFO - ], 04:58:39 INFO - [ 04:58:39 INFO - "pgo_build", 04:58:39 INFO - "False", 04:58:39 INFO - "Change" 04:58:39 INFO - ] 04:58:39 INFO - ], 04:58:39 INFO - "revision": "fcd9df15e93764277b014019a473d5d1bccd810e" 04:58:39 INFO - } 04:58:39 INFO - ], 04:58:39 INFO - "revision": "fcd9df15e93764277b014019a473d5d1bccd810e" 04:58:39 INFO - } 04:58:39 INFO - } 04:58:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/aGbSBdUXQ0OioxgcVpHllg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 04:58:39 INFO - Running post-action listener: _resource_record_post_action 04:58:39 INFO - ##### 04:58:39 INFO - ##### Running download-and-extract step. 04:58:39 INFO - ##### 04:58:39 INFO - Running pre-action listener: _resource_record_pre_action 04:58:39 INFO - Running main action method: download_and_extract 04:58:39 INFO - mkdir: /builds/slave/test/build/tests 04:58: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')]} 04:58:39 INFO - https://queue.taskcluster.net/v1/task/aGbSBdUXQ0OioxgcVpHllg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:58:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGbSBdUXQ0OioxgcVpHllg/artifacts/public/build/test_packages.json 04:58:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGbSBdUXQ0OioxgcVpHllg/artifacts/public/build/test_packages.json 04:58:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGbSBdUXQ0OioxgcVpHllg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:58:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGbSBdUXQ0OioxgcVpHllg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:58:43 INFO - Downloaded 1302 bytes. 04:58:43 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:58:44 INFO - Using the following test package requirements: 04:58:44 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:58:44 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:58:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:58:44 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:58:44 INFO - u'jsshell-linux-x86_64.zip'], 04:58:44 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:58:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:58:44 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:58:44 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:58:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:58:44 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:58:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:58:44 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:58:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:58:44 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:58:44 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:58:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:58:44 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:58:44 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')]} 04:58:44 INFO - https://queue.taskcluster.net/v1/task/aGbSBdUXQ0OioxgcVpHllg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:58:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGbSBdUXQ0OioxgcVpHllg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:58:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGbSBdUXQ0OioxgcVpHllg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:58:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGbSBdUXQ0OioxgcVpHllg/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 04:58:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGbSBdUXQ0OioxgcVpHllg/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 04:58:45 INFO - Downloaded 21793389 bytes. 04:58:45 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 04:58:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:58:45 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 04:58:46 INFO - Return code: 0 04:58:46 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 04:58:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:46 INFO - https://queue.taskcluster.net/v1/task/aGbSBdUXQ0OioxgcVpHllg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:58:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGbSBdUXQ0OioxgcVpHllg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:58:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGbSBdUXQ0OioxgcVpHllg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:58:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGbSBdUXQ0OioxgcVpHllg/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 04:58:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGbSBdUXQ0OioxgcVpHllg/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 04:58:50 INFO - Downloaded 21793389 bytes. 04:58:50 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 04:58:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:58:50 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 04:58:51 INFO - Return code: 0 04:58:51 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')]} 04:58:51 INFO - https://queue.taskcluster.net/v1/task/aGbSBdUXQ0OioxgcVpHllg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:58:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGbSBdUXQ0OioxgcVpHllg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:58:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGbSBdUXQ0OioxgcVpHllg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:58:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGbSBdUXQ0OioxgcVpHllg/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 04:58:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGbSBdUXQ0OioxgcVpHllg/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 04:58:53 INFO - Downloaded 11132001 bytes. 04:58:53 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 04:58:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:58:53 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 04:58:53 INFO - Return code: 0 04:58:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:53 INFO - https://queue.taskcluster.net/v1/task/aGbSBdUXQ0OioxgcVpHllg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:58:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGbSBdUXQ0OioxgcVpHllg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:58:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGbSBdUXQ0OioxgcVpHllg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:58:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGbSBdUXQ0OioxgcVpHllg/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 04:58:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGbSBdUXQ0OioxgcVpHllg/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 04:58:57 INFO - Downloaded 57682010 bytes. 04:58:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aGbSBdUXQ0OioxgcVpHllg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:58:57 INFO - mkdir: /builds/slave/test/properties 04:58:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:58:57 INFO - Writing to file /builds/slave/test/properties/build_url 04:58:57 INFO - Contents: 04:58:57 INFO - build_url:https://queue.taskcluster.net/v1/task/aGbSBdUXQ0OioxgcVpHllg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:58:57 INFO - Running post-action listener: _resource_record_post_action 04:58:57 INFO - Running post-action listener: set_extra_try_arguments 04:58:57 INFO - ##### 04:58:57 INFO - ##### Running populate-webroot step. 04:58:57 INFO - ##### 04:58:57 INFO - Running pre-action listener: _resource_record_pre_action 04:58:57 INFO - Running main action method: populate_webroot 04:58:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:58:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:58:57 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 04:58:57 INFO - '../fennec_ids.txt'], 04:58:57 INFO - 'tests': ['tcheck2']}, 04:58:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:58:57 INFO - '--tppagecycles', 04:58:57 INFO - '7'], 04:58:57 INFO - 'tests': ['tsvgm']}}, 04:58:57 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:58:57 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:58:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:58:57 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:58:57 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:58:57 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:58:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:58:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:58:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:58:57 INFO - 'talos_options': ['--e10s'], 04:58:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:58:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:58:57 INFO - 'tests': ['damp', 'tps']}, 04:58:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:58:57 INFO - 'talos_options': ['--e10s'], 04:58:57 INFO - 'tests': ['damp', 'tps']}, 04:58:57 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:58:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:58:57 INFO - 'other': {'tests': ['a11yr', 04:58:57 INFO - 'ts_paint', 04:58:57 INFO - 'tpaint', 04:58:57 INFO - 'sessionrestore', 04:58:57 INFO - 'sessionrestore_no_auto_restore']}, 04:58:57 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:58:57 INFO - 'tests': ['a11yr', 04:58:57 INFO - 'ts_paint', 04:58:57 INFO - 'tpaint', 04:58:57 INFO - 'sessionrestore', 04:58:57 INFO - 'sessionrestore_no_auto_restore']}, 04:58:57 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:58:57 INFO - 'tests': ['a11yr', 04:58:57 INFO - 'ts_paint', 04:58:57 INFO - 'tpaint', 04:58:57 INFO - 'sessionrestore', 04:58:57 INFO - 'sessionrestore_no_auto_restore']}, 04:58:57 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:58:57 INFO - 'tests': ['a11yr', 04:58:57 INFO - 'ts_paint', 04:58:57 INFO - 'tpaint', 04:58:57 INFO - 'sessionrestore', 04:58:57 INFO - 'sessionrestore_no_auto_restore']}, 04:58:57 INFO - 'other_l64': {'tests': ['a11yr', 04:58:57 INFO - 'ts_paint', 04:58:57 INFO - 'tpaint', 04:58:57 INFO - 'sessionrestore', 04:58:57 INFO - 'sessionrestore_no_auto_restore']}, 04:58:57 INFO - 'other_nol64': {'tests': ['a11yr', 04:58:57 INFO - 'ts_paint', 04:58:57 INFO - 'tpaint', 04:58:57 INFO - 'sessionrestore', 04:58:57 INFO - 'sessionrestore_no_auto_restore']}, 04:58:57 INFO - 'svgr': {'tests': ['tsvgx', 04:58:57 INFO - 'tsvgr_opacity', 04:58:57 INFO - 'tart', 04:58:57 INFO - 'tscrollx', 04:58:57 INFO - 'cart']}, 04:58:57 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:58:57 INFO - 'tests': ['tsvgx', 04:58:57 INFO - 'tsvgr_opacity', 04:58:57 INFO - 'tart', 04:58:57 INFO - 'tscrollx', 04:58:57 INFO - 'cart']}, 04:58:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:58:57 INFO - 'tests': ['tp5o']}, 04:58:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:58:57 INFO - 'talos_options': ['--e10s'], 04:58:57 INFO - 'tests': ['tp5o']}, 04:58:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:58:57 INFO - 'talos_options': ['--xperf_path', 04:58:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:58:57 INFO - 'tests': ['tp5n']}, 04:58:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:58:57 INFO - 'talos_options': ['--e10s', 04:58:57 INFO - '--xperf_path', 04:58:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:58:57 INFO - 'tests': ['tp5n']}}, 04:58:57 INFO - 'talos.zip': {'path': '', 04:58:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:58:57 INFO - Running post-action listener: _resource_record_post_action 04:58:57 INFO - ##### 04:58:57 INFO - ##### Running create-virtualenv step. 04:58:57 INFO - ##### 04:58:57 INFO - Running pre-action listener: _resource_record_pre_action 04:58:57 INFO - Running main action method: create_virtualenv 04:58:57 INFO - Creating virtualenv /builds/slave/test/build/venv 04:58:57 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 04:58:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:58:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:58:57 INFO - Using real prefix '/usr' 04:58:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:58:58 INFO - Installing distribute.............................................................................................................................................................................................done. 04:59:00 INFO - Installing pip.................done. 04:59:00 INFO - Return code: 0 04:59:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:59:00 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')]} 04:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:00 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')]} 04:59:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:00 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 0x7f6251a04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b59240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be80b0>, '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 0x2be8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be9440>, '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': '447a3abc0420b6a47dd38cba000001bf-1449146963.112510-1882458026', '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 04:59:00 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 04:59:00 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 04:59:00 INFO - Using env: {'DISPLAY': ':0', 04:59:00 INFO - 'HOME': '/home/cltbld', 04:59:00 INFO - 'LANG': 'en_US.UTF-8', 04:59:00 INFO - 'LANGUAGE': 'en_US:en', 04:59:00 INFO - 'LOGNAME': 'cltbld', 04:59:00 INFO - 'MAIL': '/var/mail/cltbld', 04:59:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:00 INFO - 'MOZ_NO_REMOTE': '1', 04:59:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:59:00 INFO - 'NO_EM_RESTART': '1', 04:59:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:59:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:59:00 INFO - 'PWD': '/builds/slave/test', 04:59:00 INFO - 'SHELL': '/bin/bash', 04:59:00 INFO - 'SHLVL': '1', 04:59:00 INFO - 'TERM': 'linux', 04:59:00 INFO - 'TMOUT': '86400', 04:59:00 INFO - 'USER': 'cltbld', 04:59:00 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1449146963.112510-1882458026', 04:59:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:00 INFO - '_': '/tools/buildbot/bin/python'} 04:59:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:00 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 04:59:00 INFO - Cleaning up... 04:59:00 INFO - Return code: 0 04:59:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:59:00 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')]} 04:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:00 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')]} 04:59:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:00 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 0x7f6251a04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b59240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be80b0>, '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 0x2be8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be9440>, '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': '447a3abc0420b6a47dd38cba000001bf-1449146963.112510-1882458026', '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 04:59:00 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 04:59:00 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 04:59:00 INFO - Using env: {'DISPLAY': ':0', 04:59:00 INFO - 'HOME': '/home/cltbld', 04:59:00 INFO - 'LANG': 'en_US.UTF-8', 04:59:00 INFO - 'LANGUAGE': 'en_US:en', 04:59:00 INFO - 'LOGNAME': 'cltbld', 04:59:00 INFO - 'MAIL': '/var/mail/cltbld', 04:59:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:00 INFO - 'MOZ_NO_REMOTE': '1', 04:59:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:59:00 INFO - 'NO_EM_RESTART': '1', 04:59:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:59:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:59:00 INFO - 'PWD': '/builds/slave/test', 04:59:00 INFO - 'SHELL': '/bin/bash', 04:59:00 INFO - 'SHLVL': '1', 04:59:00 INFO - 'TERM': 'linux', 04:59:00 INFO - 'TMOUT': '86400', 04:59:00 INFO - 'USER': 'cltbld', 04:59:00 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1449146963.112510-1882458026', 04:59:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:00 INFO - '_': '/tools/buildbot/bin/python'} 04:59:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:00 INFO - Downloading/unpacking psutil>=0.7.1 04:59:00 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 04:59:00 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 04:59:00 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 04:59:00 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 04:59:00 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 04:59:00 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 04:59:02 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:59:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:59:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:59:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:59:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:59:02 INFO - Installing collected packages: psutil 04:59:02 INFO - Running setup.py install for psutil 04:59:02 INFO - building 'psutil._psutil_linux' extension 04:59:02 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 04:59:02 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 04:59:02 INFO - building 'psutil._psutil_posix' extension 04:59:02 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 04:59:02 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 04:59:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:59:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:59:03 INFO - Successfully installed psutil 04:59:03 INFO - Cleaning up... 04:59:03 INFO - Return code: 0 04:59:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:59:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:03 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 0x7f6251a04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b59240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be80b0>, '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 0x2be8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be9440>, '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': '447a3abc0420b6a47dd38cba000001bf-1449146963.112510-1882458026', '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 04:59:03 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 04:59:03 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 04:59:03 INFO - Using env: {'DISPLAY': ':0', 04:59:03 INFO - 'HOME': '/home/cltbld', 04:59:03 INFO - 'LANG': 'en_US.UTF-8', 04:59:03 INFO - 'LANGUAGE': 'en_US:en', 04:59:03 INFO - 'LOGNAME': 'cltbld', 04:59:03 INFO - 'MAIL': '/var/mail/cltbld', 04:59:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:03 INFO - 'MOZ_NO_REMOTE': '1', 04:59:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:59:03 INFO - 'NO_EM_RESTART': '1', 04:59:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:59:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:59:03 INFO - 'PWD': '/builds/slave/test', 04:59:03 INFO - 'SHELL': '/bin/bash', 04:59:03 INFO - 'SHLVL': '1', 04:59:03 INFO - 'TERM': 'linux', 04:59:03 INFO - 'TMOUT': '86400', 04:59:03 INFO - 'USER': 'cltbld', 04:59:03 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1449146963.112510-1882458026', 04:59:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:03 INFO - '_': '/tools/buildbot/bin/python'} 04:59:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:59:03 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 04:59:03 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 04:59:03 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 04:59:03 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 04:59:03 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 04:59:03 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 04:59:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:59:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:59:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:59:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:59:05 INFO - Installing collected packages: mozsystemmonitor 04:59:05 INFO - Running setup.py install for mozsystemmonitor 04:59:05 INFO - Successfully installed mozsystemmonitor 04:59:05 INFO - Cleaning up... 04:59:05 INFO - Return code: 0 04:59:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:59: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')]} 04:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59: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')]} 04:59:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59: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', '--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 0x7f6251a04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b59240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be80b0>, '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 0x2be8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be9440>, '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': '447a3abc0420b6a47dd38cba000001bf-1449146963.112510-1882458026', '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 04:59:05 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 04:59:05 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 04:59:05 INFO - Using env: {'DISPLAY': ':0', 04:59:05 INFO - 'HOME': '/home/cltbld', 04:59:05 INFO - 'LANG': 'en_US.UTF-8', 04:59:05 INFO - 'LANGUAGE': 'en_US:en', 04:59:05 INFO - 'LOGNAME': 'cltbld', 04:59:05 INFO - 'MAIL': '/var/mail/cltbld', 04:59:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:05 INFO - 'MOZ_NO_REMOTE': '1', 04:59:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:59:05 INFO - 'NO_EM_RESTART': '1', 04:59:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:59:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:59:05 INFO - 'PWD': '/builds/slave/test', 04:59:05 INFO - 'SHELL': '/bin/bash', 04:59:05 INFO - 'SHLVL': '1', 04:59:05 INFO - 'TERM': 'linux', 04:59:05 INFO - 'TMOUT': '86400', 04:59:05 INFO - 'USER': 'cltbld', 04:59:05 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1449146963.112510-1882458026', 04:59:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:05 INFO - '_': '/tools/buildbot/bin/python'} 04:59:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:05 INFO - Downloading/unpacking blobuploader==1.2.4 04:59:05 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 04:59:05 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 04:59:05 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 04:59:05 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 04:59:05 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 04:59:05 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 04:59:07 INFO - Downloading blobuploader-1.2.4.tar.gz 04:59:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:59:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:59:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:59: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 04:59: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 04:59: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 04:59: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 04:59: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 04:59: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 04:59:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:59:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:59:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:59: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 04:59: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 04:59: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 04:59: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 04:59: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 04:59: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 04:59:07 INFO - Downloading docopt-0.6.1.tar.gz 04:59:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:59:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:59:07 INFO - Installing collected packages: blobuploader, requests, docopt 04:59:07 INFO - Running setup.py install for blobuploader 04:59:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:59:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:59:07 INFO - Running setup.py install for requests 04:59:08 INFO - Running setup.py install for docopt 04:59:08 INFO - Successfully installed blobuploader requests docopt 04:59:08 INFO - Cleaning up... 04:59:08 INFO - Return code: 0 04:59:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:59:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:08 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 0x7f6251a04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b59240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be80b0>, '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 0x2be8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be9440>, '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': '447a3abc0420b6a47dd38cba000001bf-1449146963.112510-1882458026', '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 04:59:08 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 04:59:08 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 04:59:08 INFO - Using env: {'DISPLAY': ':0', 04:59:08 INFO - 'HOME': '/home/cltbld', 04:59:08 INFO - 'LANG': 'en_US.UTF-8', 04:59:08 INFO - 'LANGUAGE': 'en_US:en', 04:59:08 INFO - 'LOGNAME': 'cltbld', 04:59:08 INFO - 'MAIL': '/var/mail/cltbld', 04:59:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:08 INFO - 'MOZ_NO_REMOTE': '1', 04:59:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:59:08 INFO - 'NO_EM_RESTART': '1', 04:59:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:59:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:59:08 INFO - 'PWD': '/builds/slave/test', 04:59:08 INFO - 'SHELL': '/bin/bash', 04:59:08 INFO - 'SHLVL': '1', 04:59:08 INFO - 'TERM': 'linux', 04:59:08 INFO - 'TMOUT': '86400', 04:59:08 INFO - 'USER': 'cltbld', 04:59:08 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1449146963.112510-1882458026', 04:59:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:08 INFO - '_': '/tools/buildbot/bin/python'} 04:59:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:59:08 INFO - Running setup.py (path:/tmp/pip-8zlBer-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:59:08 INFO - Running setup.py (path:/tmp/pip-Cvp4_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:59:08 INFO - Running setup.py (path:/tmp/pip-XRkKXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:59:08 INFO - Running setup.py (path:/tmp/pip-amQarz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:59:08 INFO - Running setup.py (path:/tmp/pip-HPzzYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:59:08 INFO - Running setup.py (path:/tmp/pip-0Nej20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:59:09 INFO - Running setup.py (path:/tmp/pip-QNbY32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:59:09 INFO - Running setup.py (path:/tmp/pip-8hW3V8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:59:09 INFO - Running setup.py (path:/tmp/pip-VS57v5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:59:09 INFO - Running setup.py (path:/tmp/pip-r0nn_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:59:09 INFO - Running setup.py (path:/tmp/pip-hQlTuZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:59:09 INFO - Running setup.py (path:/tmp/pip-ENW4IN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:59:09 INFO - Running setup.py (path:/tmp/pip-p6S6wu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:59:09 INFO - Running setup.py (path:/tmp/pip-4kDWuA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:59:09 INFO - Running setup.py (path:/tmp/pip-eeMEp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:59:09 INFO - Running setup.py (path:/tmp/pip-aLntac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:59:09 INFO - Running setup.py (path:/tmp/pip-EfSh5t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:59:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:59:09 INFO - Running setup.py install for manifestparser 04:59:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:59:09 INFO - Running setup.py install for mozcrash 04:59:10 INFO - Running setup.py install for mozdebug 04:59:10 INFO - Running setup.py install for mozdevice 04:59:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:59:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:59:10 INFO - Running setup.py install for mozfile 04:59:10 INFO - Running setup.py install for mozhttpd 04:59:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:59:10 INFO - Running setup.py install for mozinfo 04:59:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:59:10 INFO - Running setup.py install for mozInstall 04:59:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:59:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:59:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:59:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:59:10 INFO - Running setup.py install for mozleak 04:59:10 INFO - Running setup.py install for mozlog 04:59:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:59:10 INFO - Running setup.py install for moznetwork 04:59:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:59:10 INFO - Running setup.py install for mozprocess 04:59:11 INFO - Running setup.py install for mozprofile 04:59:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:59:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:59:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:59:11 INFO - Running setup.py install for mozrunner 04:59:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:59:11 INFO - Running setup.py install for mozscreenshot 04:59:11 INFO - Running setup.py install for moztest 04:59:11 INFO - Running setup.py install for mozversion 04:59:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:59:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:59:11 INFO - Cleaning up... 04:59:11 INFO - Return code: 0 04:59:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:59: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')]} 04:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59: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')]} 04:59:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59: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', '-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 0x7f6251a04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b59240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be80b0>, '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 0x2be8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be9440>, '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': '447a3abc0420b6a47dd38cba000001bf-1449146963.112510-1882458026', '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 04:59:11 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 04:59:11 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 04:59:11 INFO - Using env: {'DISPLAY': ':0', 04:59:11 INFO - 'HOME': '/home/cltbld', 04:59:11 INFO - 'LANG': 'en_US.UTF-8', 04:59:11 INFO - 'LANGUAGE': 'en_US:en', 04:59:11 INFO - 'LOGNAME': 'cltbld', 04:59:11 INFO - 'MAIL': '/var/mail/cltbld', 04:59:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:11 INFO - 'MOZ_NO_REMOTE': '1', 04:59:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:59:11 INFO - 'NO_EM_RESTART': '1', 04:59:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:59:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:59:11 INFO - 'PWD': '/builds/slave/test', 04:59:11 INFO - 'SHELL': '/bin/bash', 04:59:11 INFO - 'SHLVL': '1', 04:59:11 INFO - 'TERM': 'linux', 04:59:11 INFO - 'TMOUT': '86400', 04:59:11 INFO - 'USER': 'cltbld', 04:59:11 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1449146963.112510-1882458026', 04:59:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:11 INFO - '_': '/tools/buildbot/bin/python'} 04:59:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:59:11 INFO - Running setup.py (path:/tmp/pip-WIyujy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:59:11 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)) 04:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:59:11 INFO - Running setup.py (path:/tmp/pip-oiL4nM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:59:11 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)) 04:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:59:11 INFO - Running setup.py (path:/tmp/pip-6wgAV5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:59:12 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)) 04:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:59:12 INFO - Running setup.py (path:/tmp/pip-YR9EKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:59:12 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)) 04:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:59:12 INFO - Running setup.py (path:/tmp/pip-ZHZCEf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:59:12 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)) 04:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:59:12 INFO - Running setup.py (path:/tmp/pip-SSqBal-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:59:12 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)) 04:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:59:12 INFO - Running setup.py (path:/tmp/pip-jgeEPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:59:12 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)) 04:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:59:12 INFO - Running setup.py (path:/tmp/pip-BgFK0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:59:12 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)) 04:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:59:12 INFO - Running setup.py (path:/tmp/pip-zhHt8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:59:12 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)) 04:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:59:12 INFO - Running setup.py (path:/tmp/pip-6RrucM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:59:12 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)) 04:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:59:12 INFO - Running setup.py (path:/tmp/pip-qz_vW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:59:12 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)) 04:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:59:12 INFO - Running setup.py (path:/tmp/pip-HExy8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:59:12 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)) 04:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:59:12 INFO - Running setup.py (path:/tmp/pip-JBue22-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:59:12 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)) 04:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:59:12 INFO - Running setup.py (path:/tmp/pip-HGz2xh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:59:12 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)) 04:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:59:12 INFO - Running setup.py (path:/tmp/pip-22mFkE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:59:12 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)) 04:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:59:12 INFO - Running setup.py (path:/tmp/pip-25jXqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:59:12 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)) 04:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:59:12 INFO - Running setup.py (path:/tmp/pip-FG4mJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:59:13 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)) 04:59:13 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)) 04:59:13 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)) 04:59:13 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)) 04:59:13 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)) 04:59:13 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)) 04:59:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:59: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 04:59: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 04:59: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 04:59: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 04:59: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 04:59: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 04:59:14 INFO - Downloading blessings-1.5.1.tar.gz 04:59:14 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 04:59:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:59:14 INFO - Installing collected packages: blessings 04:59:14 INFO - Running setup.py install for blessings 04:59:14 INFO - Successfully installed blessings 04:59:14 INFO - Cleaning up... 04:59:14 INFO - Return code: 0 04:59:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:59:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:59:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:59:15 INFO - Reading from file tmpfile_stdout 04:59:15 INFO - Current package versions: 04:59:15 INFO - argparse == 1.2.1 04:59:15 INFO - blessings == 1.5.1 04:59:15 INFO - blobuploader == 1.2.4 04:59:15 INFO - docopt == 0.6.1 04:59:15 INFO - manifestparser == 1.1 04:59:15 INFO - mozInstall == 1.12 04:59:15 INFO - mozcrash == 0.16 04:59:15 INFO - mozdebug == 0.1 04:59:15 INFO - mozdevice == 0.47 04:59:15 INFO - mozfile == 1.2 04:59:15 INFO - mozhttpd == 0.7 04:59:15 INFO - mozinfo == 0.9 04:59:15 INFO - mozleak == 0.1 04:59:15 INFO - mozlog == 3.1 04:59:15 INFO - moznetwork == 0.27 04:59:15 INFO - mozprocess == 0.22 04:59:15 INFO - mozprofile == 0.27 04:59:15 INFO - mozrunner == 6.11 04:59:15 INFO - mozscreenshot == 0.1 04:59:15 INFO - mozsystemmonitor == 0.0 04:59:15 INFO - moztest == 0.7 04:59:15 INFO - mozversion == 1.4 04:59:15 INFO - psutil == 3.1.1 04:59:15 INFO - requests == 1.2.3 04:59:15 INFO - wsgiref == 0.1.2 04:59:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:59:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:15 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 0x7f6251a04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b59240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be80b0>, '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 0x2be8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be9440>, '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': '447a3abc0420b6a47dd38cba000001bf-1449146963.112510-1882458026', '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 04:59:15 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 04:59:15 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 04:59:15 INFO - Using env: {'DISPLAY': ':0', 04:59:15 INFO - 'HOME': '/home/cltbld', 04:59:15 INFO - 'LANG': 'en_US.UTF-8', 04:59:15 INFO - 'LANGUAGE': 'en_US:en', 04:59:15 INFO - 'LOGNAME': 'cltbld', 04:59:15 INFO - 'MAIL': '/var/mail/cltbld', 04:59:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:15 INFO - 'MOZ_NO_REMOTE': '1', 04:59:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:59:15 INFO - 'NO_EM_RESTART': '1', 04:59:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:59:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:59:15 INFO - 'PWD': '/builds/slave/test', 04:59:15 INFO - 'SHELL': '/bin/bash', 04:59:15 INFO - 'SHLVL': '1', 04:59:15 INFO - 'TERM': 'linux', 04:59:15 INFO - 'TMOUT': '86400', 04:59:15 INFO - 'USER': 'cltbld', 04:59:15 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1449146963.112510-1882458026', 04:59:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:15 INFO - '_': '/tools/buildbot/bin/python'} 04:59:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:15 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)) 04:59:15 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)) 04:59:15 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)) 04:59:15 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)) 04:59:15 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)) 04:59:15 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)) 04:59:15 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)) 04:59:15 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)) 04:59:15 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)) 04:59:15 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)) 04:59:15 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)) 04:59:15 INFO - Cleaning up... 04:59:15 INFO - Return code: 0 04:59:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:59:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:15 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 0x7f6251a04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b59240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be80b0>, '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 0x2be8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be9440>, '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': '447a3abc0420b6a47dd38cba000001bf-1449146963.112510-1882458026', '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 04:59:15 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 04:59:15 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 04:59:15 INFO - Using env: {'DISPLAY': ':0', 04:59:15 INFO - 'HOME': '/home/cltbld', 04:59:15 INFO - 'LANG': 'en_US.UTF-8', 04:59:15 INFO - 'LANGUAGE': 'en_US:en', 04:59:15 INFO - 'LOGNAME': 'cltbld', 04:59:15 INFO - 'MAIL': '/var/mail/cltbld', 04:59:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:15 INFO - 'MOZ_NO_REMOTE': '1', 04:59:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:59:15 INFO - 'NO_EM_RESTART': '1', 04:59:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:59:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:59:15 INFO - 'PWD': '/builds/slave/test', 04:59:15 INFO - 'SHELL': '/bin/bash', 04:59:15 INFO - 'SHLVL': '1', 04:59:15 INFO - 'TERM': 'linux', 04:59:15 INFO - 'TMOUT': '86400', 04:59:15 INFO - 'USER': 'cltbld', 04:59:15 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1449146963.112510-1882458026', 04:59:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:15 INFO - '_': '/tools/buildbot/bin/python'} 04:59:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:15 INFO - Downloading/unpacking jsonschema 04:59:15 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 04:59:15 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 04:59:15 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 04:59:15 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 04:59:15 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 04:59:15 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 04:59:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:59:17 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 04:59:17 INFO - Downloading/unpacking functools32 (from jsonschema) 04:59:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:17 INFO - Downloading functools32-3.2.3-2.tar.gz 04:59:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:59:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:59:17 INFO - warning: no files found matching '*.txt' 04:59:17 INFO - no previously-included directories found matching 'build' 04:59:17 INFO - no previously-included directories found matching 'dist' 04:59:17 INFO - no previously-included directories found matching '.git*' 04:59:17 INFO - Installing collected packages: jsonschema, functools32 04:59:17 INFO - Running setup.py install for functools32 04:59:17 INFO - warning: no files found matching '*.txt' 04:59:17 INFO - no previously-included directories found matching 'build' 04:59:17 INFO - no previously-included directories found matching 'dist' 04:59:17 INFO - no previously-included directories found matching '.git*' 04:59:17 INFO - Successfully installed jsonschema functools32 04:59:17 INFO - Cleaning up... 04:59:17 INFO - Return code: 0 04:59:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:59:17 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')]} 04:59:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:17 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')]} 04:59:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:17 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 0x7f6251a04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b59240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be80b0>, '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 0x2be8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be9440>, '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': '447a3abc0420b6a47dd38cba000001bf-1449146963.112510-1882458026', '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 04:59:17 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 04:59:17 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 04:59:17 INFO - Using env: {'DISPLAY': ':0', 04:59:17 INFO - 'HOME': '/home/cltbld', 04:59:17 INFO - 'LANG': 'en_US.UTF-8', 04:59:17 INFO - 'LANGUAGE': 'en_US:en', 04:59:17 INFO - 'LOGNAME': 'cltbld', 04:59:17 INFO - 'MAIL': '/var/mail/cltbld', 04:59:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:17 INFO - 'MOZ_NO_REMOTE': '1', 04:59:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:59:17 INFO - 'NO_EM_RESTART': '1', 04:59:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:59:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:59:17 INFO - 'PWD': '/builds/slave/test', 04:59:17 INFO - 'SHELL': '/bin/bash', 04:59:17 INFO - 'SHLVL': '1', 04:59:17 INFO - 'TERM': 'linux', 04:59:17 INFO - 'TMOUT': '86400', 04:59:17 INFO - 'USER': 'cltbld', 04:59:17 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1449146963.112510-1882458026', 04:59:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:17 INFO - '_': '/tools/buildbot/bin/python'} 04:59:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:17 INFO - Downloading/unpacking flake8 04:59:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:59:19 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 04:59:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:59:19 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 04:59:19 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:20 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 04:59:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:59:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:59:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:59:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:59:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:59:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:59:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:59:20 INFO - no previously-included directories found matching 'docs/_build' 04:59:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:59:20 INFO - Running setup.py install for pep8 04:59:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:59:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:59:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:59:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:59:20 INFO - no previously-included directories found matching 'docs/_build' 04:59:20 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:59:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:59:20 INFO - Cleaning up... 04:59:20 INFO - Return code: 0 04:59:20 INFO - Running post-action listener: _resource_record_post_action 04:59:20 INFO - Running post-action listener: _start_resource_monitoring 04:59:20 INFO - Starting resource monitoring. 04:59:20 INFO - ##### 04:59:20 INFO - ##### Running install step. 04:59:20 INFO - ##### 04:59:20 INFO - Running pre-action listener: _resource_record_pre_action 04:59:20 INFO - Running main action method: install 04:59:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:59:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:59:20 INFO - Reading from file tmpfile_stdout 04:59:20 INFO - Detecting whether we're running mozinstall >=1.0... 04:59:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:59:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:59:20 INFO - Reading from file tmpfile_stdout 04:59:20 INFO - Output received: 04:59:20 INFO - Usage: mozinstall [options] installer 04:59:20 INFO - Options: 04:59:20 INFO - -h, --help show this help message and exit 04:59:20 INFO - -d DEST, --destination=DEST 04:59:20 INFO - Directory to install application into. [default: 04:59:20 INFO - "/builds/slave/test"] 04:59:20 INFO - --app=APP Application being installed. [default: firefox] 04:59:20 INFO - mkdir: /builds/slave/test/build/application 04:59:20 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'] 04:59:20 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 04:59:35 INFO - Reading from file tmpfile_stdout 04:59:35 INFO - Output received: 04:59:35 INFO - /builds/slave/test/build/application/firefox/firefox 04:59:35 INFO - Running post-action listener: _resource_record_post_action 04:59:35 INFO - ##### 04:59:35 INFO - ##### Running run-tests step. 04:59:35 INFO - ##### 04:59:35 INFO - Running pre-action listener: _resource_record_pre_action 04:59:35 INFO - Running main action method: run_tests 04:59:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:59:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:59:35 INFO - Python 2.7.3 04:59:35 INFO - Return code: 0 04:59:35 INFO - grabbing minidump binary from tooltool 04:59:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:35 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 0x2be80b0>, '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 0x2be8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be9440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:59:35 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 04:59:35 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 04:59:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:59:35 INFO - Return code: 0 04:59:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:59:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:59:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:59:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:59:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:59:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:59:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:59:36 INFO - Return code: 0 04:59:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Cedar', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aGbSBdUXQ0OioxgcVpHllg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost'] in /builds/slave/test/build 04:59:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Cedar --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aGbSBdUXQ0OioxgcVpHllg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --webServer localhost 04:59:36 INFO - Using env: {'DISPLAY': ':0', 04:59:36 INFO - 'HOME': '/home/cltbld', 04:59:36 INFO - 'LANG': 'en_US.UTF-8', 04:59:36 INFO - 'LANGUAGE': 'en_US:en', 04:59:36 INFO - 'LOGNAME': 'cltbld', 04:59:36 INFO - 'MAIL': '/var/mail/cltbld', 04:59:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:59:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:59:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:36 INFO - 'MOZ_NO_REMOTE': '1', 04:59:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:59:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:59:36 INFO - 'NO_EM_RESTART': '1', 04:59:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:59:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:59:36 INFO - 'PWD': '/builds/slave/test', 04:59:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:59:36 INFO - 'SHELL': '/bin/bash', 04:59:36 INFO - 'SHLVL': '1', 04:59:36 INFO - 'TERM': 'linux', 04:59:36 INFO - 'TMOUT': '86400', 04:59:36 INFO - 'USER': 'cltbld', 04:59:36 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1449146963.112510-1882458026', 04:59:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:36 INFO - '_': '/tools/buildbot/bin/python'} 04:59:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Cedar', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aGbSBdUXQ0OioxgcVpHllg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost'] with output_timeout 3600 04:59:36 INFO - mozversion INFO | application_buildid: 20151203034831 04:59:36 INFO - mozversion INFO | application_changeset: fcd9df15e93764277b014019a473d5d1bccd810e 04:59:36 INFO - mozversion INFO | application_display_name: Nightly 04:59:36 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:59:36 INFO - mozversion INFO | application_name: Firefox 04:59:36 INFO - mozversion INFO | application_remotingname: firefox 04:59:36 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/projects/cedar 04:59:36 INFO - mozversion INFO | application_vendor: Mozilla 04:59:36 INFO - mozversion INFO | application_version: 45.0a1 04:59:36 INFO - mozversion INFO | platform_buildid: 20151203034831 04:59:36 INFO - mozversion INFO | platform_changeset: fcd9df15e93764277b014019a473d5d1bccd810e 04:59:36 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/projects/cedar 04:59:36 INFO - mozversion INFO | platform_version: 45.0a1 04:59:36 INFO - 2015-12-03 04:59:36,600 DEBUG : using testdate: 1449147576 04:59:36 INFO - 2015-12-03 04:59:36,600 DEBUG : actual date: 1449147576 04:59:36 INFO - 2015-12-03 04:59:36,608 INFO : starting webserver on 'localhost:40310' 04:59:36 INFO - 2015-12-03 04:59:36,609 INFO : Starting test suite talos-linux64-ix-027 04:59:36 INFO - 2015-12-03 04:59:36,610 INFO : Starting test dromaeo_css 04:59:36 INFO - 2015-12-03 04:59:36,610 DEBUG : operating with platform_type : linux_ 04:59:36 INFO - 2015-12-03 04:59:36,610 INFO : Initialising browser for dromaeo_css test... 04:59:36 INFO - 2015-12-03 04:59:36,627 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXxHgTc/profile http://localhost:40310/getInfo.html 04:59:40 INFO - 2015-12-03 04:59:40,917 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:59:40 INFO - 2015-12-03 04:59:40,918 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:59:40 INFO - 2015-12-03 04:59:40,918 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:59:40 INFO - 2015-12-03 04:59:40,918 DEBUG : BROWSER_OUTPUT: __metrics 04:59:41 INFO - 2015-12-03 04:59:41,014 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:59:41 INFO - 2015-12-03 04:59:41,015 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] 04:59:42 INFO - 2015-12-03 04:59:42,248 INFO : Browser initialized. 04:59:42 INFO - 2015-12-03 04:59:42,249 INFO : Running cycle 1/1 for dromaeo_css test... 04:59:42 INFO - 2015-12-03 04:59:42,249 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXxHgTc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:59:54 INFO - 2015-12-03 04:59:54,262 DEBUG : BROWSER_OUTPUT: RSS: Main: 142839808 04:59:54 INFO - 2015-12-03 04:59:54,263 DEBUG : BROWSER_OUTPUT: 05:00:45 INFO - 2015-12-03 05:00:45,543 DEBUG : BROWSER_OUTPUT: 1449147645542 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] 05:02:57 INFO - 2015-12-03 05:02:57,671 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40310/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40310/tests/dromaeo/cssquery-ext.html) 05:02:58 INFO - 2015-12-03 05:02:58,822 DEBUG : BROWSER_OUTPUT: RSS: Main: 246939648 05:02:58 INFO - 2015-12-03 05:02:58,822 DEBUG : BROWSER_OUTPUT: 05:06:01 INFO - 2015-12-03 05:06:01,332 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40310/tests/dromaeo/cssquery-ext.html (next: http://localhost:40310/tests/dromaeo/cssquery-jquery.html) 05:06:01 INFO - 2015-12-03 05:06:01,901 DEBUG : BROWSER_OUTPUT: RSS: Main: 226951168 05:06:01 INFO - 2015-12-03 05:06:01,902 DEBUG : BROWSER_OUTPUT: 05:09:03 INFO - 2015-12-03 05:09:03,930 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40310/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40310/tests/dromaeo/cssquery-mootools.html) 05:09:04 INFO - 2015-12-03 05:09:04,500 DEBUG : BROWSER_OUTPUT: RSS: Main: 223027200 05:09:04 INFO - 2015-12-03 05:09:04,500 DEBUG : BROWSER_OUTPUT: 05:12:06 INFO - 2015-12-03 05:12:06,447 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40310/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40310/tests/dromaeo/cssquery-prototype.html) 05:12:07 INFO - 2015-12-03 05:12:07,033 DEBUG : BROWSER_OUTPUT: RSS: Main: 201945088 05:12:07 INFO - 2015-12-03 05:12:07,033 DEBUG : BROWSER_OUTPUT: 05:15:09 INFO - 2015-12-03 05:15:09,941 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40310/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40310/tests/dromaeo/cssquery-yui.html) 05:15:10 INFO - 2015-12-03 05:15:10,527 DEBUG : BROWSER_OUTPUT: RSS: Main: 203591680 05:15:10 INFO - 2015-12-03 05:15:10,528 DEBUG : BROWSER_OUTPUT: 05:18:13 INFO - 2015-12-03 05:18:13,072 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40310/tests/dromaeo/cssquery-yui.html (next: http://localhost:40310/tests/dromaeo/cssquery-dojo.html) 05:18:13 INFO - 2015-12-03 05:18:13,322 DEBUG : BROWSER_OUTPUT: RSS: Main: 253571072 05:18:13 INFO - 2015-12-03 05:18:13,322 DEBUG : BROWSER_OUTPUT: 05:18:13 INFO - 2015-12-03 05:18:13,322 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:18:13 INFO - 2015-12-03 05:18:13,323 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:18:13 INFO - 2015-12-03 05:18:13,323 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:18:13 INFO - 2015-12-03 05:18:13,323 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:18:13 INFO - 2015-12-03 05:18:13,326 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2591.6242144888993;2699.880593733918;2702.378452955819;2710.7018227994904;2720.0615787553293;4494.6853720239515;4613.930791038137;4641.187792136376;4700.623950083989;4707.599854012409;4507.661925355604;4608.446986361633;4678.695884767488;4680.040591678706;4771.689840160388;4184.100418410041;4262.97868510657;4289.292266775986;4365.519792822787;4423;4374.431323927901;4437.4675038995365;4438.112377524508;4442.822287108512;4464.888377790565;4151.647109995654;4267.381229721673;4276.123394704078;4325.913481730379;4394.868153955386;4355.716878402894;4363.912721745579;4365.934510982338;4368.934465983013;4389.692721509496;4345.608895199447;4353.499347575038;4361.738295702236;4369.2353838078525;4382.780860956939;4466.330050492452;4564.5435456454425;4583;4594.035252596958;4665.860024199245;5048.1670524363435;5048.671836330626;5048.7223202723835;5057.241413787924;5098.235264710286;5074.264231686385;5079.1365467870555;5089.109405853961;5089.41471730752;5091.898162036776;4468.419105516295;4542.8864278392975;4552.248878934939;4642.46611639659;4743.739094349844;5137.794488220504;5186.81846135391;5194.065068287745;5201.479852014844;5202.167653175549;4958.206686930146;4984.601231901439;4984.8753781155765;4988.176950803149;5032.018756342478;4867.853964381075;4924.704517728876;4984.800607975641;4986.027724593742;5037.748112594356;4987.526185012418;4990.700557966534;5003.549680528697;5008.29883816266;5055.873603159876;4979.850604481871;4980.626453016038;4982.975085124551;4983.651144419929;5029.698218106925;4041.818118184689;4101.753894766323;4144.088300573869;4191.077962848169;4232;3615.1142969972525;3667.1382225177063;3671.3575124353133;3689.8339574718666;3712.2389910068373;4276.508201556799;4278.679099067583;4280.250956082673;4318.676099292503;4321.632661223831;4795.664303498722;4921.261810728348;4928.581070609039;5030.320906677552;5030.647854650139;4231.069164783743;4282.336237883133;4295.82816687329;4336.891577710519;4338.305871060616;4410.977945110254;4413.801378937956;4417.15478888815;4454;4461.219286624892;4530.864074077783;4629.467611224618;4744.833930812405;4746.5490778376;4751.548602882721;4895.143349913679;4976.950230497793;4979.601631869369;4995.700257984533;5029.145045342228;4733.414834959235;4733.5503127202865;4741.857744267678;4749.477557468745;4776.95223047779;4785.425748910153;4897.510248975074;4945.332380128637;4945.431275403231;4993.3259010034635;4994.500549944976;5032.370953630796;5098.413682426569;5123.513266239701;5138.845834624967;4885.682430641997;4924.433690125681;4925.507449255046;4926.137925862888;4971.850844474671;4679.251319788954;4795.472498025145;4903.485134060872;4938.851834444972;4939.777710002986;4726.3146843708155;4790.5448982346625;4857.9028419432125;4867.123917694707;4901.215805471107;4894.535019173173;4916.508349165055;4918.532739389752;4922.064807686528;4955.900881982412;4689.484156742687;4815.711057336431;4824.252240902666;4825.638077144158;4826 05:18:13 INFO - 2015-12-03 05:18:13,326 DEBUG : BROWSER_OUTPUT: |1;ext.html;560.688817706173;561.19188368749;567.775728587208;569.8660814708543;571.5513322042198;25703.871480642592;26350.736492635067;26355.736442635567;35472;36067;38743.80628096862;39132;39216.41175382372;39310.21379572407;39618.80190599043;7858.253465920757;8041.959790201041;8043.758687239363;8046.517208967452;8052.5973701315;7183.964080179618;7373.373263272628;10190.64332748354;10492.737681557946;10494.790104197911;9928.10647041766;10202.38785672862;10212.029857163594;10214.387136771817;10215.693529194099;6886;7015.508914375996;10065.849012264822;10143.949280253626;10192.082712555868;10211.846822297672;10468.371897686164;10488.58045678172;10515.369077855277;10531.315464494783;37216.81391593052;37820.43269350962;37834.43248351277;37868.43197352014;37893.0526736831;2754.559270516708;2807.8034537582375;2876.7698584113223;3502.8248587570774;3566;28227.85886070577;28303;28493.57259641107;28685.56971645427;29093.563596545857;3339.6159441664036;3399.5750531183603;3440.776349537272;3488.3372159289906;3540.238848647553;214888;215446;215658;215833;216614;48979;52138.47861521336;52475;52485;52589.2111618326;44971;61465.38534614686;62392.00863930875;62428.68785656043;62675;13131.474741010252;13406.463741450429;13455;13459.865401346056;13474.19154850712;10025.047620476043;10107.797844043078;10179;10204.285700000928;10214.336068155546;17443.21505532254;17661.116944152996;17767.733483997752;17824.821751782576;17896.731549026776;7033.577985320897;7162.713491460283;7319.487635865545;7340.669669864869;7357.632118394166;822.1408627983652;839.6347588798892;875.1423604867266;973.6251543155794;1012.4077414712328;25638.063751605576;25992.610110848353;26268.73731262663;26269;26272.474550508883;965.3435663748578;967.434051080126;1021.9540120694587;1032.8347464405808;1039.0804138337626;13102.344882755824;13221.93389033068;13240.271785051915;13357.666058348424;13364.866351336557;357542;368500;368638;369210;369541;43074;43421.34867976983;43432;43510.56489435065;43619;1194.1581185264367;1207.571312184162;1220.3471142938663;1223.1682455929874;1224.908131890112;24540.631890522014;25279.36801579975;25882.48235035251;25890.87054564715;25962.35094122662;37012.409131360546;37400.812995934844;37445.81277093597;37455.06362340963;37462.250754984205;221891;303895;308296;333685;342203;27151.72848271492;27299.454010920068;27308.59037114405;27316.863415682794;27650.92618053614;36593.81703091467;37100.25799483941;37457.06357341088;37948.430773538974;37981.810090949366;31518;31843.36313273768;32255.193620159684;32643.510347344334;32887.835560822044;31912.07521612659;32651.673483265815;32701;32838.83580582082;33010.33979320352;31807.522887157174;32208.83895580507;32526.674733252363;32574.185645359055;32683;28754.712452875203;28873.133805985854;29588.408231834812;30130.84934575313;30338.393232134793;21641;22985.88507057454;24443.633345500188;24935;25325.873370633766 05:18:13 INFO - 2015-12-03 05:18:13,330 DEBUG : BROWSER_OUTPUT: |2;jquery.html;328.54988665528214;328.5843408088767;328.9129427242964;334.79600225838726;336.35587849268654;12671.366431678402;13069.803952940714;14920;15638.530844074681;16171.919140404296;8321.209485098922;9677;9762.658306959258;9937.155341795957;9959.751006224848;4473.798679059434;4631.490536041033;4634.629229661636;4637.536246375369;4639.420072490939;3262.755293352996;3367.579052618423;4459;4517.4579050513985;5127.051495473331;5100.336956195708;5141.537261646451;5150.124478838607;5150.1759718445055;5151.536361727443;5004.224345226496;5110.310108135392;5134.563562097226;5140.408852981899;5145.536901678829;4945.67853089548;4957.281194226817;4958.801647934079;4959.181735013718;4964.05682920244;11951.521939122425;12848.357582120856;17767.378141764977;19556.80443195578;19562;1810.7464954906325;1825.7535232743542;1837.6692195404821;1857.7677790276216;1922.135039232337;8649.827003459959;8780.692675756382;9023.233025192867;9062.954685226598;9223.031581683894;1689.7972243330755;1715.6054107555333;1730.1898236996262;1757.5166829121965;1780.9198586063658;53854.19218711722;56195.43804561943;56339.99999999959;57650.71174644142;57657.42342576604;10046.296759226783;10052.296339256181;10072.597096116073;10080.09279164864;10145.137663298554;12548.749025019632;12708.364581770875;12717.364131793373;12728.172668776686;12754.426050827735;6911.101556797584;6933;6959.582425054412;6969.860602787916;7001.474889383317;6584.176977877765;6611.63636000015;6612.338766123446;6670.39966403026;6674.733010679518;4237.6821738369745;4239.300515414922;4250.341197114452;4252.893677658021;4305.526392096866;1621.829707880679;1676.1535424610493;1700.9914950425168;1735.5921358480748;1743.2504023270117;381.47547122706277;880.423322723617;915.1031988651159;922.3036607361399;954.2366107114419;9590.42457452555;9863.950680246697;10014.449205293779;10127.189824813997;10221.488925553842;364.9817509124533;401.3518168158403;402.981865816039;411.3480133987663;418.318141429468;5398.973005135028;5558.499735023867;9109.362344635945;9499.667511637197;9790.902090979;453807;455544;457607;475799;481531;70528;73358;74830.62584687042;75486.62256688681;75606;1032.5921261101823;1048.2714513413105;1050.0444595418285;1057.8942105789513;1081.167501024207;14666.706665866835;14901;14914.627134321729;15081;15265.313060912064;35389.823050885614;35468.290634186655;35559.82220088883;35633;35847;45949;46848.53151468578;47009.52990470052;49803.501964979885;49887.75056124696;8863.335249856416;8999.820003600022;9001.504917229353;9097.545122743704;9127.08729127082;15584.454544090902;15689.843101568838;16149.838501614833;16281;16530.752038719187;12984.220946743226;13300.866991329964;13428.798568021683;13614.115082519604;13826.723465530431;12446.751064978831;13041.413136409074;13072.80390794158;13325;13535.458581657018;10546.314489558154;13461.730765384833;13588.45646174142;13814.171149731048;14204.644883877985;8355.874661879956;8703.564821759013;8870.51212183336;8872.201501864864;8890.110988901059;12271.386430678253;12358.258504489759;12492.437840297027;13506.122102063335;13555.32223388807 05:18:13 INFO - 2015-12-03 05:18:13,331 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1422.6727852593897;1628.7394016957285;1667.0997661262918;1699.3372584691965;1710.2560386231987;5420.1327787554;7114.395276401506;7253.673584688689;7273.599952002651;7284.854302913938;7084.822879428017;7223.4221262299025;7231.096112985877;7242.31198036187;7270.818229544264;1764.5588602849289;1814.28335807356;2077.542940553076;2134.7331583552054;2176.34709587124;2134.0716788197105;2140.6039882621685;2144.8391370647187;2144.849860509757;2146.2809958663865;2043.8058384453452;2064.886431246281;2080.022389476951;2083.3541602103396;2084.6456102462616;1725.7583938248656;1756.56085978506;2075.190675636503;2119.8622089564283;2124.129107066111;2112.4296439961126;2121.5332626822074;2144.9356519304447;2147.044565168501;2149.0436755643746;7210.855782884313;7271.854562908765;7307.926920730778;7308.671109800019;7330.193678695339;4235.047114399266;4285.97136687196;4304.655627549789;4316.223079845627;4318.892027699301;2707.0795929383908;2725.6320396746582;2731.5219836528527;2769.8615069246457;2792.706765789583;867.6486023160567;902.3908861518514;919.6689191890914;928.0765638189977;928.9489078100702;9650.613975440974;9690.806183876353;9720.90279097207;9738.805223895482;9761.219102471714;3985.960140398617;4076.286649836267;4111.8972025699595;4116.217918595457;4138.213739389506;8361.540115293596;8364.749057528285;8373.246407823324;8377.916220837713;8393.916060839436;4291.377750226262;4300.053988122608;4303.505096913895;4306.289462238696;4308.030693094029;3887.3197190492115;3909.4722212500947;3914.784686842194;3919.451276821247;3921.039345360348;3429.605595356566;3440.552728145375;3452.861885524551;3480.443129099332;3480.825958702055;1127.7518945831903;1145.118258940611;1149.7987852125846;1155.064397837754;1161.7618388230392;846.6063280574563;915.3592485260344;1141.3494308244221;1153.2388623508443;1163.4996951310848;6689.899651505231;6758.662066896733;6777.830554236183;6780.1524809398825;6794.592324460449;1042.3954106618144;1042.5725452564411;1079.1312993040522;1086.2667699303097;1087.7661302819931;5060.949390506122;5089.643724939218;5095.133827249377;5098.872528186751;5099.209622508443;8526.360522960802;8552.529610871461;8654.697085601974;8798.824023519623;8872.423292485968;8602.655893764178;8673.6530538779;8702.303815694855;8745.868811967826;8797.956010219908;6687.598744075371;6715;6752.3922846944015;6786.524943253925;6902.758403455855;6434.0670602763275;6438.29178790342;6441.1304473895425;6447.484201263794;6470.741170353322;7655.732049378245;7786;7882;7940;8009.078955920144;7969.641366138421;7974.720884769005;8053.516788992445;8127.878081828895;8245.093039765741;5792.507636850746;5860.413958604106;5876;5877.324107727666;5884.58807883444;6588.967055164885;6769.356911093439;6769.966150169218;6806.7957961261245;6811.489138314745;6356.078368636429;6425.1968503937005;6443.484521238383;6513.73945042193;6544.574602650812;5180.352455943007;6078.908816367846;6360.4911607072245;6461;6537.1174891389055;6533.607983520814;6561.3438656134;6580.5722628029025;6588.40704336612;6590.5716128451495;5900.881982360243;6005.699715014144;6042.818715438544;6044.184035155197;6055.515558755201;6131.110988906495;6172.938270617236;6179.28938172116;6194.318624951342;6194.969025154845 05:18:13 INFO - 2015-12-03 05:18:13,333 DEBUG : BROWSER_OUTPUT: |4;prototype.html;296.63662014032826;302.3710681781894;306.8757153352892;308.34015207456036;312.71855330202817;5264.8157314494;5268.341457317835;5298.390685071218;5299.5230429261455;5318.122509785885;5186.351706036746;5210.062188806013;5233.2150177473395;5241.606879484045;5255.527002569768;3908.5505166905887;4079.9184016319655;4083.7549747015128;4091.652209562191;4093.9560412094875;4034.1931613677234;4041.1513582147786;4041.333180025307;4041.4341992121126;4043.3732771420478;3970.940435893464;4092.3452247640384;4095.9590404096025;4097.160082183145;4098.877033688994;4067.247559201557;4081.918361632751;4086.284900142493;4087.448194493735;4094.0583665756894;3417.026147547937;3525.1010992197084;3563.6436356364416;3618.620044895301;3624.72814538908;5052.9747351263;5060.51925067118;5063.063333283354;5086.4659210783075;5097.235414687826;4725.432948046257;4735.715857048588;4738.549837765407;4741.075490279397;4742.099001189763;5516.779328826842;5531.3915469298345;5534.391216966131;5534.754680196964;5539.750711218005;3848.230353929225;3961.207758448293;3979.383195604686;3980.920381592352;3984.780837053961;5818.41815818419;5824.155497452845;5825.7087145642545;5829.096490044008;5835.416458354173;4110.321796903538;4113.670906327487;4114.156597897424;4116.115035267432;4116.300228961084;4167.229062623424;4172.290710579148;4172.645325147336;4175.498940127204;4176.561461046546;4251.17102165081;4400.295952647561;4476.686631935799;4713.434387873477;4715.95284047162;5344.839654810362;5384.596155288369;5408.513233808976;5429.348478182644;5515.338159420895;1414.3211258595725;1431.6349330920548;1432.44134787433;1432.8495507971513;1434.4477376210025;959.9136077753036;960.0495509445599;963.4508330251689;979.0601023017982;980.460746589373;4836.492168322346;4889.462159162489;4891.853244402673;4893.412790465167;4893.804247830119;5772.220750198753;5774;5777.508911742549;5779.797707080232;5781.4507621775865;4831.806727730851;4854.927176092291;4864.854054378375;4866.489018653061;4870.123377791961;2900.3329234276234;3015.517517197238;3081.8613162407746;3112.797668151563;3115.5326700995033;4588.197065513522;5160.303359046481;5195.792168313225;5422.132458806651;5454.318210223722;5932.762689492372;5946.67293298864;5947.49446297061;5952.196453478811;5954.255718035246;5445.37378201504;5459.563234941115;5461.644993075437;5462.453754624506;5464.0711079116645;5796.1305804129715;5799.043157879071;5801.506871915934;5808.680522571299;5809.360970293349;5415.83752487426;5619.2133101365025;5659.405762394889;5665.376808550974;5678.4605462480995;5309.920351194813;5319.308489896289;5333.333333333333;5478.479544443271;5484.8354549363585;4023.094803669151;4027.1140349123148;4027.516697996259;4035.9798201008807;4036.656884164879;5788.913166302593;5801.477866991991;5803.593748437737;5809.5352371811;5810.912836307374;5443.156310771837;5569.331680198402;5604.607677462538;5612.550995920398;5624.381318054929;5616.466435688603;5618.831435056954;5626.746796394254;5631.887362252814;5632.127020311858;5493.807716729895;5497.038018346853;5513.669179849222;5514.972425137848;5515.889682206413;5489.34127904638;5629.240052592848;5647.350554686263;5657.4908258256955;5660.830175094754;5481.835544933659;5501.642393244426;5503.972480137573;5508.063629183129;5511.145772405283 05:18:13 INFO - 2015-12-03 05:18:13,334 DEBUG : BROWSER_OUTPUT: |5;yui.html;677.9830504237392;718.0736849464191;738.1732459645198;753.2730914667345;755.199488542145;11218.214724969255;11461.770764584724;11535.307881527115;11548.191626586153;11576.421178941051;11149.21955463116;11221.495032723527;11229.933156350155;11231.438428078603;11247.325160490376;614.7264467312048;626.0171530696808;756.29286617013;771.4368510986969;788.5702292250709;779.2052106851008;779.6998155710036;785.0265670568483;785.5365334452672;785.5914924239393;818.251300060447;824.5135370131621;825.2696363718122;825.9256666899978;827.0571548434789;650.7559665125578;661.193344120175;813.3980854167933;830.2195935820309;830.2735106781566;614.2690198663621;614.5268143529502;614.6834380294152;614.7510258345377;615.3477314047079;10495.580176792919;10622.09712174466;10640.308379955279;10669.35983840972;10691.946540267249;10961.616343427942;11410.429478526123;11665.766684666343;11721.179517433782;12141.453634586465;8669.436486628412;8857.247133993618;8889.644414223423;8965.775855603597;9164.770880727969;3253.6258330292085;3279.8688052477873;3280.2619410632656;3283.162793487669;3283.96716032839;39899.40150897739;40018.39972400387;40290;40377;40623.796881015405;8803.735887923373;9004.684836030707;9061.59222834974;9162.633494660273;9307.022762609964;16837.831621683872;16905.49283521496;16936.661266774594;16942.57643558921;16965.406210782563;6424.16485856845;6465.612063276124;6575.539712220194;6599.373059559334;6671.032700258435;3377.223238655123;3388.186835159544;3404.4212483877304;3404.6084700259294;3455.127662435324;2644.6694163229595;2693.5959606059246;2694.474577457377;2700.203439985209;2700.7434293742062;500.1697182676739;500.60452242728564;506.9670471419346;508.4534125814764;518.5177784660302;540.2949151357516;557.9856717250722;558.701094914219;566.6345207341242;574.810312596842;7069.681864316118;7202.92797072033;7243.637818109179;7310.671019804122;7339.816504587428;387.1695213766455;396.8849033780229;468.10124560843263;494.2314700640467;512.5873671694322;3538.57537095545;3589.5692516897616;3709.350863598859;3746.063484128968;3779.5842457330223;47532.5246747535;49202.753986229836;49556.75221623869;49577.75211123921;49957.75021124944;41175.7941210298;41333.379999300036;41712.58287417087;41867.371989420186;41937.37093943593;39734;41282.58717412847;41316.38025429621;41540.75377738673;42686.146277074906;7601.619919004138;7960.761177164694;7979.122296547491;8057.879131813144;8113.878291825746;31735.682643173273;32053.35893282168;32134;32591.837040814644;32600;37211.44182837205;38532.807335964266;40492;40544.1891162181;40902.1819563613;9379.249660027317;9713.125818676353;9851.901480985098;9886.30795844284;10074.949625251827;11006.229563930448;11080.501377438195;11181;11409.315441073562;11629.418529073344;9997.850032249376;10277.486125693835;10503.579856805642;10523.315984460985;11142.275752076413;10313.22650801208;10505.632302869362;10546.20903432261;10875.238733288594;10944.781104378028;9941.751456213653;9991.100800927952;10116.544755485873;10158.238132139972;10273.486325683536;9256.305777066882;9374.812503750023;9409.576569054272;9481.194098501428;9564.187044101329;8991.14584114508;9283.72148835536;9362.765930851783;9448.419545230769;9453.101955314234 05:18:13 INFO - 2015-12-03 05:18:13,334 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:18:13 INFO - 2015-12-03 05:18:13,334 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:18:13 INFO - 2015-12-03 05:18:13,334 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,957 05:18:13 INFO - 2015-12-03 05:18:13,335 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:18:13 INFO - 2015-12-03 05:18:13,335 DEBUG : BROWSER_OUTPUT: __startTimestamp1449148693321__endTimestamp 05:18:13 INFO - 2015-12-03 05:18:13,335 DEBUG : BROWSER_OUTPUT: 05:18:13 INFO - 2015-12-03 05:18:13,335 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:18:13 INFO - 2015-12-03 05:18:13,335 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:18:13 INFO - 2015-12-03 05:18:13,335 DEBUG : BROWSER_OUTPUT: 05:18:13 INFO - 2015-12-03 05:18:13,335 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4626.00 Median:4744.83 stddev:485.39 (10.2%) stddev-sans-first:459.89 05:18:13 INFO - 2015-12-03 05:18:13,335 DEBUG : BROWSER_OUTPUT: Values: 2591.6 2699.9 2702.4 2710.7 2720.1 4494.7 4613.9 4641.2 4700.6 4707.6 4507.7 4608.4 4678.7 4680.0 4771.7 4184.1 4263.0 4289.3 4365.5 4423.0 4374.4 4437.5 4438.1 4442.8 4464.9 4151.6 4267.4 4276.1 4325.9 4394.9 4355.7 4363.9 4365.9 4368.9 4389.7 4345.6 4353.5 4361.7 4369.2 4382.8 4466.3 4564.5 4583.0 4594.0 4665.9 5048.2 5048.7 5048.7 5057.2 5098.2 5074.3 5079.1 5089.1 5089.4 5091.9 4468.4 4542.9 4552.2 4642.5 4743.7 5137.8 5186.8 5194.1 5201.5 5202.2 4958.2 4984.6 4984.9 4988.2 5032.0 4867.9 4924.7 4984.8 4986.0 5037.7 4987.5 4990.7 5003.5 5008.3 5055.9 4979.9 4980.6 4983.0 4983.7 5029.7 4041.8 4101.8 4144.1 4191.1 4232.0 3615.1 3667.1 3671.4 3689.8 3712.2 4276.5 4278.7 4280.3 4318.7 4321.6 4795.7 4921.3 4928.6 5030.3 5030.6 4231.1 4282.3 4295.8 4336.9 4338.3 4411.0 4413.8 4417.2 4454.0 4461.2 4530.9 4629.5 4744.8 4746.5 4751.5 4895.1 4977.0 4979.6 4995.7 5029.1 4733.4 4733.6 4741.9 4749.5 4777.0 4785.4 4897.5 4945.3 4945.4 4993.3 4994.5 5032.4 5098.4 5123.5 5138.8 4885.7 4924.4 4925.5 4926.1 4971.9 4679.3 4795.5 4903.5 4938.9 4939.8 4726.3 4790.5 4857.9 4867.1 4901.2 4894.5 4916.5 4918.5 4922.1 4955.9 4689.5 4815.7 4824.3 4825.6 4826.0 05:18:13 INFO - 2015-12-03 05:18:13,335 DEBUG : BROWSER_OUTPUT: 05:18:13 INFO - 2015-12-03 05:18:13,336 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:44353.07 Median:31877.72 stddev:79581.06 (249.6%) stddev-sans-first:79736.38 05:18:13 INFO - 2015-12-03 05:18:13,337 DEBUG : BROWSER_OUTPUT: Values: 560.7 561.2 567.8 569.9 571.6 25703.9 26350.7 26355.7 35472.0 36067.0 38743.8 39132.0 39216.4 39310.2 39618.8 7858.3 8042.0 8043.8 8046.5 8052.6 7184.0 7373.4 10190.6 10492.7 10494.8 9928.1 10202.4 10212.0 10214.4 10215.7 6886.0 7015.5 10065.8 10143.9 10192.1 10211.8 10468.4 10488.6 10515.4 10531.3 37216.8 37820.4 37834.4 37868.4 37893.1 2754.6 2807.8 2876.8 3502.8 3566.0 28227.9 28303.0 28493.6 28685.6 29093.6 3339.6 3399.6 3440.8 3488.3 3540.2 214888.0 215446.0 215658.0 215833.0 216614.0 48979.0 52138.5 52475.0 52485.0 52589.2 44971.0 61465.4 62392.0 62428.7 62675.0 13131.5 13406.5 13455.0 13459.9 13474.2 10025.0 10107.8 10179.0 10204.3 10214.3 17443.2 17661.1 17767.7 17824.8 17896.7 7033.6 7162.7 7319.5 7340.7 7357.6 822.1 839.6 875.1 973.6 1012.4 25638.1 25992.6 26268.7 26269.0 26272.5 965.3 967.4 1022.0 1032.8 1039.1 13102.3 13221.9 13240.3 13357.7 13364.9 357542.0 368500.0 368638.0 369210.0 369541.0 43074.0 43421.3 43432.0 43510.6 43619.0 1194.2 1207.6 1220.3 1223.2 1224.9 24540.6 25279.4 25882.5 25890.9 25962.4 37012.4 37400.8 37445.8 37455.1 37462.3 221891.0 303895.0 308296.0 333685.0 342203.0 27151.7 27299.5 27308.6 27316.9 27650.9 36593.8 37100.3 37457.1 37948.4 37981.8 31518.0 31843.4 32255.2 32643.5 32887.8 31912.1 32651.7 32701.0 32838.8 33010.3 31807.5 32208.8 32526.7 32574.2 32683.0 28754.7 28873.1 29588.4 30130.8 30338.4 21641.0 22985.9 24443.6 24935.0 25325.9 05:18:13 INFO - 2015-12-03 05:18:13,337 DEBUG : BROWSER_OUTPUT: 05:18:13 INFO - 2015-12-03 05:18:13,337 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25540.89 Median:2328.00 stddev:76152.28 (3271.1%) stddev-sans-first:76342.37 05:18:13 INFO - 2015-12-03 05:18:13,337 DEBUG : BROWSER_OUTPUT: Values: 328.5 328.6 328.9 334.8 336.4 12671.4 13069.8 14920.0 15638.5 16171.9 8321.2 9677.0 9762.7 9937.2 9959.8 4473.8 4631.5 4634.6 4637.5 4639.4 3262.8 3367.6 4459.0 4517.5 5127.1 5100.3 5141.5 5150.1 5150.2 5151.5 5004.2 5110.3 5134.6 5140.4 5145.5 4945.7 4957.3 4958.8 4959.2 4964.1 11951.5 12848.4 17767.4 19556.8 19562.0 1810.7 1825.8 1837.7 1857.8 1922.1 8649.8 8780.7 9023.2 9063.0 9223.0 1689.8 1715.6 1730.2 1757.5 1780.9 53854.2 56195.4 56340.0 57650.7 57657.4 10046.3 10052.3 10072.6 10080.1 10145.1 12548.7 12708.4 12717.4 12728.2 12754.4 6911.1 6933.0 6959.6 6969.9 7001.5 6584.2 6611.6 6612.3 6670.4 6674.7 4237.7 4239.3 4250.3 4252.9 4305.5 1621.8 1676.2 1701.0 1735.6 1743.3 381.5 880.4 915.1 922.3 954.2 9590.4 9864.0 10014.4 10127.2 10221.5 365.0 401.4 403.0 411.3 418.3 5399.0 5558.5 9109.4 9499.7 9790.9 453807.0 455544.0 457607.0 475799.0 481531.0 70528.0 73358.0 74830.6 75486.6 75606.0 1032.6 1048.3 1050.0 1057.9 1081.2 14666.7 14901.0 14914.6 15081.0 15265.3 35389.8 35468.3 35559.8 35633.0 35847.0 45949.0 46848.5 47009.5 49803.5 49887.8 8863.3 8999.8 9001.5 9097.5 9127.1 15584.5 15689.8 16149.8 16281.0 16530.8 12984.2 13300.9 13428.8 13614.1 13826.7 12446.8 13041.4 13072.8 13325.0 13535.5 10546.3 13461.7 13588.5 13814.2 14204.6 8355.9 8703.6 8870.5 8872.2 8890.1 12271.4 12358.3 12492.4 13506.1 13555.3 05:18:13 INFO - 2015-12-03 05:18:13,338 DEBUG : BROWSER_OUTPUT: 05:18:13 INFO - 2015-12-03 05:18:13,338 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5018.41 Median:6105.01 stddev:2595.48 (42.5%) stddev-sans-first:2588.69 05:18:13 INFO - 2015-12-03 05:18:13,339 DEBUG : BROWSER_OUTPUT: Values: 1422.7 1628.7 1667.1 1699.3 1710.3 5420.1 7114.4 7253.7 7273.6 7284.9 7084.8 7223.4 7231.1 7242.3 7270.8 1764.6 1814.3 2077.5 2134.7 2176.3 2134.1 2140.6 2144.8 2144.8 2146.3 2043.8 2064.9 2080.0 2083.4 2084.6 1725.8 1756.6 2075.2 2119.9 2124.1 2112.4 2121.5 2144.9 2147.0 2149.0 7210.9 7271.9 7307.9 7308.7 7330.2 4235.0 4286.0 4304.7 4316.2 4318.9 2707.1 2725.6 2731.5 2769.9 2792.7 867.6 902.4 919.7 928.1 928.9 9650.6 9690.8 9720.9 9738.8 9761.2 3986.0 4076.3 4111.9 4116.2 4138.2 8361.5 8364.7 8373.2 8377.9 8393.9 4291.4 4300.1 4303.5 4306.3 4308.0 3887.3 3909.5 3914.8 3919.5 3921.0 3429.6 3440.6 3452.9 3480.4 3480.8 1127.8 1145.1 1149.8 1155.1 1161.8 846.6 915.4 1141.3 1153.2 1163.5 6689.9 6758.7 6777.8 6780.2 6794.6 1042.4 1042.6 1079.1 1086.3 1087.8 5060.9 5089.6 5095.1 5098.9 5099.2 8526.4 8552.5 8654.7 8798.8 8872.4 8602.7 8673.7 8702.3 8745.9 8798.0 6687.6 6715.0 6752.4 6786.5 6902.8 6434.1 6438.3 6441.1 6447.5 6470.7 7655.7 7786.0 7882.0 7940.0 8009.1 7969.6 7974.7 8053.5 8127.9 8245.1 5792.5 5860.4 5876.0 5877.3 5884.6 6589.0 6769.4 6770.0 6806.8 6811.5 6356.1 6425.2 6443.5 6513.7 6544.6 5180.4 6078.9 6360.5 6461.0 6537.1 6533.6 6561.3 6580.6 6588.4 6590.6 5900.9 6005.7 6042.8 6044.2 6055.5 6131.1 6172.9 6179.3 6194.3 6195.0 05:18:13 INFO - 2015-12-03 05:18:13,339 DEBUG : BROWSER_OUTPUT: 05:18:13 INFO - 2015-12-03 05:18:13,340 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4609.09 Median:5237.41 stddev:1352.15 (25.8%) stddev-sans-first:1316.63 05:18:13 INFO - 2015-12-03 05:18:13,340 DEBUG : BROWSER_OUTPUT: Values: 296.6 302.4 306.9 308.3 312.7 5264.8 5268.3 5298.4 5299.5 5318.1 5186.4 5210.1 5233.2 5241.6 5255.5 3908.6 4079.9 4083.8 4091.7 4094.0 4034.2 4041.2 4041.3 4041.4 4043.4 3970.9 4092.3 4096.0 4097.2 4098.9 4067.2 4081.9 4086.3 4087.4 4094.1 3417.0 3525.1 3563.6 3618.6 3624.7 5053.0 5060.5 5063.1 5086.5 5097.2 4725.4 4735.7 4738.5 4741.1 4742.1 5516.8 5531.4 5534.4 5534.8 5539.8 3848.2 3961.2 3979.4 3980.9 3984.8 5818.4 5824.2 5825.7 5829.1 5835.4 4110.3 4113.7 4114.2 4116.1 4116.3 4167.2 4172.3 4172.6 4175.5 4176.6 4251.2 4400.3 4476.7 4713.4 4716.0 5344.8 5384.6 5408.5 5429.3 5515.3 1414.3 1431.6 1432.4 1432.8 1434.4 959.9 960.0 963.5 979.1 980.5 4836.5 4889.5 4891.9 4893.4 4893.8 5772.2 5774.0 5777.5 5779.8 5781.5 4831.8 4854.9 4864.9 4866.5 4870.1 2900.3 3015.5 3081.9 3112.8 3115.5 4588.2 5160.3 5195.8 5422.1 5454.3 5932.8 5946.7 5947.5 5952.2 5954.3 5445.4 5459.6 5461.6 5462.5 5464.1 5796.1 5799.0 5801.5 5808.7 5809.4 5415.8 5619.2 5659.4 5665.4 5678.5 5309.9 5319.3 5333.3 5478.5 5484.8 4023.1 4027.1 4027.5 4036.0 4036.7 5788.9 5801.5 5803.6 5809.5 5810.9 5443.2 5569.3 5604.6 5612.6 5624.4 5616.5 5618.8 5626.7 5631.9 5632.1 5493.8 5497.0 5513.7 5515.0 5515.9 5489.3 5629.2 5647.4 5657.5 5660.8 5481.8 5501.6 5504.0 5508.1 5511.1 05:18:13 INFO - 2015-12-03 05:18:13,340 DEBUG : BROWSER_OUTPUT: 05:18:13 INFO - 2015-12-03 05:18:13,340 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12098.84 Median:24000.31 stddev:13671.08 (57.0%) stddev-sans-first:13682.53 05:18:13 INFO - 2015-12-03 05:18:13,340 DEBUG : BROWSER_OUTPUT: Values: 678.0 718.1 738.2 753.3 755.2 11218.2 11461.8 11535.3 11548.2 11576.4 11149.2 11221.5 11229.9 11231.4 11247.3 614.7 626.0 756.3 771.4 788.6 779.2 779.7 785.0 785.5 785.6 818.3 824.5 825.3 825.9 827.1 650.8 661.2 813.4 830.2 830.3 614.3 614.5 614.7 614.8 615.3 10495.6 10622.1 10640.3 10669.4 10691.9 10961.6 11410.4 11665.8 11721.2 12141.5 8669.4 8857.2 8889.6 8965.8 9164.8 3253.6 3279.9 3280.3 3283.2 3284.0 39899.4 40018.4 40290.0 40377.0 40623.8 8803.7 9004.7 9061.6 9162.6 9307.0 16837.8 16905.5 16936.7 16942.6 16965.4 6424.2 6465.6 6575.5 6599.4 6671.0 3377.2 3388.2 3404.4 3404.6 3455.1 2644.7 2693.6 2694.5 2700.2 2700.7 500.2 500.6 507.0 508.5 518.5 540.3 558.0 558.7 566.6 574.8 7069.7 7202.9 7243.6 7310.7 7339.8 387.2 396.9 468.1 494.2 512.6 3538.6 3589.6 3709.4 3746.1 3779.6 47532.5 49202.8 49556.8 49577.8 49957.8 41175.8 41333.4 41712.6 41867.4 41937.4 39734.0 41282.6 41316.4 41540.8 42686.1 7601.6 7960.8 7979.1 8057.9 8113.9 31735.7 32053.4 32134.0 32591.8 32600.0 37211.4 38532.8 40492.0 40544.2 40902.2 9379.2 9713.1 9851.9 9886.3 10074.9 11006.2 11080.5 11181.0 11409.3 11629.4 9997.9 10277.5 10503.6 10523.3 11142.3 10313.2 10505.6 10546.2 10875.2 10944.8 9941.8 9991.1 10116.5 10158.2 10273.5 9256.3 9374.8 9409.6 9481.2 9564.2 8991.1 9283.7 9362.8 9448.4 9453.1 05:18:13 INFO - 2015-12-03 05:18:13,341 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:18:13 INFO - 2015-12-03 05:18:13,341 DEBUG : BROWSER_OUTPUT: 05:18:14 INFO - 2015-12-03 05:18:14,077 INFO : Browser exited with error code: 0 05:18:14 INFO - 2015-12-03 05:18:14,096 INFO : Completed test dromaeo_css (00:18:37) 05:18:14 INFO - 2015-12-03 05:18:14,096 INFO : Starting test kraken 05:18:14 INFO - 2015-12-03 05:18:14,096 DEBUG : operating with platform_type : linux_ 05:18:14 INFO - 2015-12-03 05:18:14,096 INFO : Initialising browser for kraken test... 05:18:14 INFO - 2015-12-03 05:18:14,102 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwMPbv4/profile http://localhost:40310/getInfo.html 05:18:18 INFO - 2015-12-03 05:18:18,562 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:18:18 INFO - 2015-12-03 05:18:18,562 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:18:18 INFO - 2015-12-03 05:18:18,563 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:18:18 INFO - 2015-12-03 05:18:18,563 DEBUG : BROWSER_OUTPUT: __metrics 05:18:18 INFO - 2015-12-03 05:18:18,659 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:18:18 INFO - 2015-12-03 05:18:18,660 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] 05:18:19 INFO - 2015-12-03 05:18:19,522 INFO : Browser initialized. 05:18:19 INFO - 2015-12-03 05:18:19,523 INFO : Running cycle 1/1 for kraken test... 05:18:19 INFO - 2015-12-03 05:18:19,523 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwMPbv4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:18:31 INFO - 2015-12-03 05:18:31,535 DEBUG : BROWSER_OUTPUT: RSS: Main: 143683584 05:18:31 INFO - 2015-12-03 05:18:31,535 DEBUG : BROWSER_OUTPUT: 05:18:34 INFO - 2015-12-03 05:18:34,158 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40310/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40310/tests/kraken/driver.html?testName=audio-beat-detection) 05:18:34 INFO - 2015-12-03 05:18:34,745 DEBUG : BROWSER_OUTPUT: RSS: Main: 182030336 05:18:34 INFO - 2015-12-03 05:18:34,745 DEBUG : BROWSER_OUTPUT: 05:18:37 INFO - 2015-12-03 05:18:37,507 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40310/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40310/tests/kraken/driver.html?testName=audio-dft) 05:18:38 INFO - 2015-12-03 05:18:38,080 DEBUG : BROWSER_OUTPUT: RSS: Main: 170070016 05:18:38 INFO - 2015-12-03 05:18:38,080 DEBUG : BROWSER_OUTPUT: 05:18:41 INFO - 2015-12-03 05:18:41,072 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40310/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40310/tests/kraken/driver.html?testName=audio-fft) 05:18:41 INFO - 2015-12-03 05:18:41,641 DEBUG : BROWSER_OUTPUT: RSS: Main: 153612288 05:18:41 INFO - 2015-12-03 05:18:41,641 DEBUG : BROWSER_OUTPUT: 05:18:43 INFO - 2015-12-03 05:18:43,674 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40310/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40310/tests/kraken/driver.html?testName=audio-oscillator) 05:18:44 INFO - 2015-12-03 05:18:44,243 DEBUG : BROWSER_OUTPUT: RSS: Main: 155934720 05:18:44 INFO - 2015-12-03 05:18:44,243 DEBUG : BROWSER_OUTPUT: 05:18:46 INFO - 2015-12-03 05:18:46,484 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40310/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40310/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:18:47 INFO - 2015-12-03 05:18:47,050 DEBUG : BROWSER_OUTPUT: RSS: Main: 157839360 05:18:47 INFO - 2015-12-03 05:18:47,050 DEBUG : BROWSER_OUTPUT: 05:18:50 INFO - 2015-12-03 05:18:50,074 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40310/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40310/tests/kraken/driver.html?testName=imaging-darkroom) 05:18:50 INFO - 2015-12-03 05:18:50,657 DEBUG : BROWSER_OUTPUT: RSS: Main: 156839936 05:18:50 INFO - 2015-12-03 05:18:50,657 DEBUG : BROWSER_OUTPUT: 05:18:54 INFO - 2015-12-03 05:18:54,023 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40310/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40310/tests/kraken/driver.html?testName=imaging-desaturate) 05:18:54 INFO - 2015-12-03 05:18:54,605 DEBUG : BROWSER_OUTPUT: RSS: Main: 158674944 05:18:54 INFO - 2015-12-03 05:18:54,605 DEBUG : BROWSER_OUTPUT: 05:18:57 INFO - 2015-12-03 05:18:57,448 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40310/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40310/tests/kraken/driver.html?testName=json-parse-financial) 05:18:58 INFO - 2015-12-03 05:18:58,029 DEBUG : BROWSER_OUTPUT: RSS: Main: 156860416 05:18:58 INFO - 2015-12-03 05:18:58,029 DEBUG : BROWSER_OUTPUT: 05:18:59 INFO - 2015-12-03 05:18:59,758 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40310/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40310/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:19:00 INFO - 2015-12-03 05:19:00,324 DEBUG : BROWSER_OUTPUT: RSS: Main: 168579072 05:19:00 INFO - 2015-12-03 05:19:00,324 DEBUG : BROWSER_OUTPUT: 05:19:02 INFO - 2015-12-03 05:19:02,196 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40310/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40310/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:19:02 INFO - 2015-12-03 05:19:02,797 DEBUG : BROWSER_OUTPUT: RSS: Main: 167342080 05:19:02 INFO - 2015-12-03 05:19:02,798 DEBUG : BROWSER_OUTPUT: 05:19:04 INFO - 2015-12-03 05:19:04,935 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40310/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40310/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:19:05 INFO - 2015-12-03 05:19:05,521 DEBUG : BROWSER_OUTPUT: RSS: Main: 181420032 05:19:05 INFO - 2015-12-03 05:19:05,521 DEBUG : BROWSER_OUTPUT: 05:19:08 INFO - 2015-12-03 05:19:08,024 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40310/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40310/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:19:08 INFO - 2015-12-03 05:19:08,610 DEBUG : BROWSER_OUTPUT: RSS: Main: 185745408 05:19:08 INFO - 2015-12-03 05:19:08,610 DEBUG : BROWSER_OUTPUT: 05:19:11 INFO - 2015-12-03 05:19:11,205 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40310/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40310/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:19:11 INFO - 2015-12-03 05:19:11,785 DEBUG : BROWSER_OUTPUT: RSS: Main: 184340480 05:19:11 INFO - 2015-12-03 05:19:11,785 DEBUG : BROWSER_OUTPUT: 05:19:13 INFO - 2015-12-03 05:19:13,518 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40310/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40310/tests/kraken/driver.html?testName=ai-astar) 05:19:13 INFO - 2015-12-03 05:19:13,769 DEBUG : BROWSER_OUTPUT: RSS: Main: 243130368 05:19:13 INFO - 2015-12-03 05:19:13,769 DEBUG : BROWSER_OUTPUT: 05:19:13 INFO - 2015-12-03 05:19:13,772 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:19:13 INFO - 2015-12-03 05:19:13,772 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:19:13 INFO - 2015-12-03 05:19:13,773 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:19:13 INFO - 2015-12-03 05:19:13,773 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:19:13 INFO - 2015-12-03 05:19:13,773 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;114;105;112;112;112;107;112;114;106 05:19:13 INFO - 2015-12-03 05:19:13,773 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;127;159;166;127;165;158;128;164;128 05:19:13 INFO - 2015-12-03 05:19:13,773 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;162;161;160;161;161;161;162;162;161 05:19:13 INFO - 2015-12-03 05:19:13,773 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;82;90;72;72;73;105;88;73 05:19:13 INFO - 2015-12-03 05:19:13,773 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;96;133;95;95;94;128;94;94;126 05:19:13 INFO - 2015-12-03 05:19:13,773 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;109;109;109;110;109;109;109;111 05:19:13 INFO - 2015-12-03 05:19:13,774 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;148;145;147;147;148;148;148;146 05:19:13 INFO - 2015-12-03 05:19:13,774 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;96;95;96;95;96;96;96 05:19:13 INFO - 2015-12-03 05:19:13,774 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;71;70;71;70;71;72;81;69;68 05:19:13 INFO - 2015-12-03 05:19:13,774 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;67;69;68;68;68;67;68;69 05:19:13 INFO - 2015-12-03 05:19:13,774 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;86;86;85;83;82;85;85;85;83 05:19:13 INFO - 2015-12-03 05:19:13,774 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;119;120;128;127;124;119;125;122;121;119 05:19:13 INFO - 2015-12-03 05:19:13,774 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;147;145;144;150;144;134;148;145;144;134 05:19:13 INFO - 2015-12-03 05:19:13,775 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;68;68;68;68;68;70;71;67;67 05:19:13 INFO - 2015-12-03 05:19:13,775 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:19:13 INFO - 2015-12-03 05:19:13,775 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:19:13 INFO - 2015-12-03 05:19:13,775 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,990 05:19:13 INFO - 2015-12-03 05:19:13,775 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:19:13 INFO - 2015-12-03 05:19:13,775 DEBUG : BROWSER_OUTPUT: __startTimestamp1449148753771__endTimestamp 05:19:13 INFO - 2015-12-03 05:19:13,775 DEBUG : BROWSER_OUTPUT: 05:19:13 INFO - 2015-12-03 05:19:13,779 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:19:13 INFO - 2015-12-03 05:19:13,779 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:19:13 INFO - 2015-12-03 05:19:13,779 DEBUG : BROWSER_OUTPUT: 05:19:13 INFO - 2015-12-03 05:19:13,779 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.60 Median:112.00 stddev:3.31 (3.0%) stddev-sans-first:3.47 05:19:13 INFO - 2015-12-03 05:19:13,779 DEBUG : BROWSER_OUTPUT: Values: 112.0 114.0 105.0 112.0 112.0 112.0 107.0 112.0 114.0 106.0 05:19:13 INFO - 2015-12-03 05:19:13,779 DEBUG : BROWSER_OUTPUT: 05:19:13 INFO - 2015-12-03 05:19:13,779 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:147.60 Median:158.50 stddev:17.66 (11.1%) stddev-sans-first:18.58 05:19:13 INFO - 2015-12-03 05:19:13,779 DEBUG : BROWSER_OUTPUT: Values: 154.0 127.0 159.0 166.0 127.0 165.0 158.0 128.0 164.0 128.0 05:19:13 INFO - 2015-12-03 05:19:13,779 DEBUG : BROWSER_OUTPUT: 05:19:13 INFO - 2015-12-03 05:19:13,780 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.67 (0.4%) stddev-sans-first:0.67 05:19:13 INFO - 2015-12-03 05:19:13,780 DEBUG : BROWSER_OUTPUT: Values: 162.0 162.0 161.0 160.0 161.0 161.0 161.0 162.0 162.0 161.0 05:19:13 INFO - 2015-12-03 05:19:13,780 DEBUG : BROWSER_OUTPUT: 05:19:13 INFO - 2015-12-03 05:19:13,780 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.00 Median:73.00 stddev:11.22 (15.4%) stddev-sans-first:11.52 05:19:13 INFO - 2015-12-03 05:19:13,780 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 82.0 90.0 72.0 72.0 73.0 105.0 88.0 73.0 05:19:13 INFO - 2015-12-03 05:19:13,780 DEBUG : BROWSER_OUTPUT: 05:19:13 INFO - 2015-12-03 05:19:13,780 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.00 Median:94.50 stddev:16.66 (17.6%) stddev-sans-first:17.27 05:19:13 INFO - 2015-12-03 05:19:13,780 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 133.0 95.0 95.0 94.0 128.0 94.0 94.0 126.0 05:19:13 INFO - 2015-12-03 05:19:13,780 DEBUG : BROWSER_OUTPUT: 05:19:13 INFO - 2015-12-03 05:19:13,780 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 05:19:13 INFO - 2015-12-03 05:19:13,780 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 109.0 109.0 109.0 110.0 109.0 109.0 109.0 111.0 05:19:13 INFO - 2015-12-03 05:19:13,780 DEBUG : BROWSER_OUTPUT: 05:19:13 INFO - 2015-12-03 05:19:13,780 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.50 stddev:1.05 (0.7%) stddev-sans-first:1.12 05:19:13 INFO - 2015-12-03 05:19:13,780 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 148.0 145.0 147.0 147.0 148.0 148.0 148.0 146.0 05:19:13 INFO - 2015-12-03 05:19:13,780 DEBUG : BROWSER_OUTPUT: 05:19:13 INFO - 2015-12-03 05:19:13,780 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 05:19:13 INFO - 2015-12-03 05:19:13,781 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 96.0 95.0 96.0 95.0 96.0 96.0 96.0 05:19:13 INFO - 2015-12-03 05:19:13,781 DEBUG : BROWSER_OUTPUT: 05:19:13 INFO - 2015-12-03 05:19:13,781 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.40 Median:71.00 stddev:3.57 (5.0%) stddev-sans-first:3.78 05:19:13 INFO - 2015-12-03 05:19:13,781 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 70.0 71.0 70.0 71.0 72.0 81.0 69.0 68.0 05:19:13 INFO - 2015-12-03 05:19:13,781 DEBUG : BROWSER_OUTPUT: 05:19:13 INFO - 2015-12-03 05:19:13,781 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 05:19:13 INFO - 2015-12-03 05:19:13,781 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 67.0 69.0 68.0 68.0 68.0 67.0 68.0 69.0 05:19:13 INFO - 2015-12-03 05:19:13,781 DEBUG : BROWSER_OUTPUT: 05:19:13 INFO - 2015-12-03 05:19:13,781 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:85.00 stddev:1.42 (1.7%) stddev-sans-first:1.42 05:19:13 INFO - 2015-12-03 05:19:13,781 DEBUG : BROWSER_OUTPUT: Values: 83.0 86.0 86.0 85.0 83.0 82.0 85.0 85.0 85.0 83.0 05:19:13 INFO - 2015-12-03 05:19:13,781 DEBUG : BROWSER_OUTPUT: 05:19:13 INFO - 2015-12-03 05:19:13,781 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.40 Median:123.00 stddev:3.41 (2.8%) stddev-sans-first:3.38 05:19:13 INFO - 2015-12-03 05:19:13,781 DEBUG : BROWSER_OUTPUT: Values: 119.0 120.0 128.0 127.0 124.0 119.0 125.0 122.0 121.0 119.0 05:19:13 INFO - 2015-12-03 05:19:13,781 DEBUG : BROWSER_OUTPUT: 05:19:13 INFO - 2015-12-03 05:19:13,781 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.50 Median:145.00 stddev:5.38 (3.7%) stddev-sans-first:5.56 05:19:13 INFO - 2015-12-03 05:19:13,781 DEBUG : BROWSER_OUTPUT: Values: 147.0 145.0 144.0 150.0 144.0 134.0 148.0 145.0 144.0 134.0 05:19:13 INFO - 2015-12-03 05:19:13,782 DEBUG : BROWSER_OUTPUT: 05:19:13 INFO - 2015-12-03 05:19:13,782 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.00 stddev:1.25 (1.8%) stddev-sans-first:1.32 05:19:13 INFO - 2015-12-03 05:19:13,782 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 68.0 68.0 68.0 68.0 70.0 71.0 67.0 67.0 05:19:13 INFO - 2015-12-03 05:19:13,782 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:19:13 INFO - 2015-12-03 05:19:13,782 DEBUG : BROWSER_OUTPUT: 05:19:14 INFO - 2015-12-03 05:19:14,685 INFO : Browser exited with error code: 0 05:19:14 INFO - 2015-12-03 05:19:14,738 INFO : Completed test kraken (00:01:00) 05:19:14 INFO - 2015-12-03 05:19:14,738 INFO : Starting test v8_7 05:19:14 INFO - 2015-12-03 05:19:14,739 DEBUG : operating with platform_type : linux_ 05:19:14 INFO - 2015-12-03 05:19:14,739 INFO : Initialising browser for v8_7 test... 05:19:14 INFO - 2015-12-03 05:19:14,745 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyM7Wiq/profile http://localhost:40310/getInfo.html 05:19:19 INFO - 2015-12-03 05:19:19,305 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:19:19 INFO - 2015-12-03 05:19:19,306 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:19:19 INFO - 2015-12-03 05:19:19,306 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:19:19 INFO - 2015-12-03 05:19:19,306 DEBUG : BROWSER_OUTPUT: __metrics 05:19:19 INFO - 2015-12-03 05:19:19,394 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:19:19 INFO - 2015-12-03 05:19:19,395 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] 05:19:19 ERROR - 2015-12-03 05:19:19,477 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 05:19:20 INFO - 2015-12-03 05:19:20,465 INFO : Browser initialized. 05:19:20 INFO - 2015-12-03 05:19:20,466 INFO : Running cycle 1/1 for v8_7 test... 05:19:20 INFO - 2015-12-03 05:19:20,466 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyM7Wiq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:19:32 INFO - 2015-12-03 05:19:32,485 DEBUG : BROWSER_OUTPUT: RSS: Main: 143970304 05:19:32 INFO - 2015-12-03 05:19:32,486 DEBUG : BROWSER_OUTPUT: 05:19:53 INFO - 2015-12-03 05:19:53,880 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40310/tests/v8_7/run.html (next: http://localhost:40310/tests/v8_7/run.html) 05:19:54 INFO - 2015-12-03 05:19:54,124 DEBUG : BROWSER_OUTPUT: RSS: Main: 443387904 05:19:54 INFO - 2015-12-03 05:19:54,124 DEBUG : BROWSER_OUTPUT: 05:19:54 INFO - 2015-12-03 05:19:54,125 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:19:54 INFO - 2015-12-03 05:19:54,125 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:19:54 INFO - 2015-12-03 05:19:54,125 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:19:54 INFO - 2015-12-03 05:19:54,126 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:19:54 INFO - 2015-12-03 05:19:54,126 DEBUG : BROWSER_OUTPUT: |0;Richards;165.31658125309968 05:19:54 INFO - 2015-12-03 05:19:54,126 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;183.35166850018337 05:19:54 INFO - 2015-12-03 05:19:54,126 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.6291446085261 05:19:54 INFO - 2015-12-03 05:19:54,126 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5181.347150259067 05:19:54 INFO - 2015-12-03 05:19:54,126 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1998.0039920159682 05:19:54 INFO - 2015-12-03 05:19:54,127 DEBUG : BROWSER_OUTPUT: |5;Earley;779.423226812159 05:19:54 INFO - 2015-12-03 05:19:54,127 DEBUG : BROWSER_OUTPUT: |6;Boyer;12072.289156626506 05:19:54 INFO - 2015-12-03 05:19:54,127 DEBUG : BROWSER_OUTPUT: |7;RegExp;26205.128205128207 05:19:54 INFO - 2015-12-03 05:19:54,127 DEBUG : BROWSER_OUTPUT: |8;Splay;605.3268765133172 05:19:54 INFO - 2015-12-03 05:19:54,128 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 05:19:54 INFO - 2015-12-03 05:19:54,128 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:19:54 INFO - 2015-12-03 05:19:54,128 DEBUG : BROWSER_OUTPUT: __startTimestamp1449148794124__endTimestamp 05:19:54 INFO - 2015-12-03 05:19:54,128 DEBUG : BROWSER_OUTPUT: 05:19:54 INFO - 2015-12-03 05:19:54,129 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:19:54 INFO - 2015-12-03 05:19:54,129 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:19:54 INFO - 2015-12-03 05:19:54,129 DEBUG : BROWSER_OUTPUT: 05:19:54 INFO - 2015-12-03 05:19:54,130 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.32 Median:165.32 stddev:0.00 (0.0%) 05:19:54 INFO - 2015-12-03 05:19:54,130 DEBUG : BROWSER_OUTPUT: Values: 165.3 05:19:54 INFO - 2015-12-03 05:19:54,130 DEBUG : BROWSER_OUTPUT: 05:19:54 INFO - 2015-12-03 05:19:54,130 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:183.35 Median:183.35 stddev:0.00 (0.0%) 05:19:54 INFO - 2015-12-03 05:19:54,130 DEBUG : BROWSER_OUTPUT: Values: 183.4 05:19:54 INFO - 2015-12-03 05:19:54,131 DEBUG : BROWSER_OUTPUT: 05:19:54 INFO - 2015-12-03 05:19:54,131 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.63 Median:278.63 stddev:0.00 (0.0%) 05:19:54 INFO - 2015-12-03 05:19:54,131 DEBUG : BROWSER_OUTPUT: Values: 278.6 05:19:54 INFO - 2015-12-03 05:19:54,131 DEBUG : BROWSER_OUTPUT: 05:19:54 INFO - 2015-12-03 05:19:54,132 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5181.35 Median:5181.35 stddev:0.00 (0.0%) 05:19:54 INFO - 2015-12-03 05:19:54,132 DEBUG : BROWSER_OUTPUT: Values: 5181.3 05:19:54 INFO - 2015-12-03 05:19:54,132 DEBUG : BROWSER_OUTPUT: 05:19:54 INFO - 2015-12-03 05:19:54,132 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1998.00 Median:1998.00 stddev:0.00 (0.0%) 05:19:54 INFO - 2015-12-03 05:19:54,133 DEBUG : BROWSER_OUTPUT: Values: 1998.0 05:19:54 INFO - 2015-12-03 05:19:54,133 DEBUG : BROWSER_OUTPUT: 05:19:54 INFO - 2015-12-03 05:19:54,133 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:779.42 Median:779.42 stddev:0.00 (0.0%) 05:19:54 INFO - 2015-12-03 05:19:54,133 DEBUG : BROWSER_OUTPUT: Values: 779.4 05:19:54 INFO - 2015-12-03 05:19:54,133 DEBUG : BROWSER_OUTPUT: 05:19:54 INFO - 2015-12-03 05:19:54,133 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12072.29 Median:12072.29 stddev:0.00 (0.0%) 05:19:54 INFO - 2015-12-03 05:19:54,133 DEBUG : BROWSER_OUTPUT: Values: 12072.3 05:19:54 INFO - 2015-12-03 05:19:54,134 DEBUG : BROWSER_OUTPUT: 05:19:54 INFO - 2015-12-03 05:19:54,134 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26205.13 Median:26205.13 stddev:0.00 (0.0%) 05:19:54 INFO - 2015-12-03 05:19:54,134 DEBUG : BROWSER_OUTPUT: Values: 26205.1 05:19:54 INFO - 2015-12-03 05:19:54,134 DEBUG : BROWSER_OUTPUT: 05:19:54 INFO - 2015-12-03 05:19:54,134 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:605.33 Median:605.33 stddev:0.00 (0.0%) 05:19:54 INFO - 2015-12-03 05:19:54,134 DEBUG : BROWSER_OUTPUT: Values: 605.3 05:19:54 INFO - 2015-12-03 05:19:54,134 DEBUG : BROWSER_OUTPUT: 05:19:54 INFO - 2015-12-03 05:19:54,134 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 05:19:54 INFO - 2015-12-03 05:19:54,135 DEBUG : BROWSER_OUTPUT: Values: 4840.6 05:19:54 INFO - 2015-12-03 05:19:54,135 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:19:54 INFO - 2015-12-03 05:19:54,135 DEBUG : BROWSER_OUTPUT: 05:19:55 INFO - 2015-12-03 05:19:55,069 INFO : Browser exited with error code: 0 05:19:55 INFO - 2015-12-03 05:19:55,084 INFO : Completed test v8_7 (00:00:40) 05:19:55 INFO - 2015-12-03 05:19:55,156 INFO : Completed test suite (00:20:18) 05:19:55 INFO - 2015-12-03 05:19:55,156 DEBUG : Working with test: dromaeo_css 05:19:55 INFO - 2015-12-03 05:19:55,156 DEBUG : Generating results file: dromaeo_css 05:19:55 INFO - 2015-12-03 05:19:55,157 DEBUG : Working with test: kraken 05:19:55 INFO - 2015-12-03 05:19:55,157 DEBUG : Generating results file: kraken 05:19:55 INFO - 2015-12-03 05:19:55,157 INFO : javascript benchmark 05:19:55 INFO - 2015-12-03 05:19:55,158 DEBUG : Working with test: v8_7 05:19:55 INFO - 2015-12-03 05:19:55,158 DEBUG : Generating results file: v8_7 05:19:55 INFO - 2015-12-03 05:19:55,158 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:19:55 INFO - 2015-12-03 05:19:55,214 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,26,35]] 05:19:55 INFO - 2015-12-03 05:19:55,214 DEBUG : process_Request line: dromaeo_css 6242.14 graph.html#tests=[[72,26,35]] 05:19:55 INFO - 2015-12-03 05:19:55,214 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:19:55 INFO - 2015-12-03 05:19:55,242 DEBUG : process_Request line: kraken 1514.40 graph.html#tests=[[232,26,35]] 05:19:55 INFO - 2015-12-03 05:19:55,242 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:19:55 INFO - 2015-12-03 05:19:55,277 DEBUG : process_Request line: v8_7 19922.95 graph.html#tests=[[230,26,35]] 05:19:55 INFO - 2015-12-03 05:19:55,278 INFO : javascript benchmark 05:19:55 INFO - 2015-12-03 05:19:55,282 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2591.6242144888993, 2699.880593733918, 2702.378452955819, 2710.7018227994904, 2720.0615787553293, 4494.6853720239515, 4613.930791038137, 4641.187792136376, 4700.623950083989, 4707.599854012409, 4507.661925355604, 4608.446986361633, 4678.695884767488, 4680.040591678706, 4771.689840160388, 4184.100418410041, 4262.97868510657, 4289.292266775986, 4365.519792822787, 4423.0, 4374.431323927901, 4437.4675038995365, 4438.112377524508, 4442.822287108512, 4464.888377790565, 4151.647109995654, 4267.381229721673, 4276.123394704078, 4325.913481730379, 4394.868153955386, 4355.716878402894, 4363.912721745579, 4365.934510982338, 4368.934465983013, 4389.692721509496, 4345.608895199447, 4353.499347575038, 4361.738295702236, 4369.2353838078525, 4382.780860956939, 4466.330050492452, 4564.5435456454425, 4583.0, 4594.035252596958, 4665.860024199245, 5048.1670524363435, 5048.671836330626, 5048.7223202723835, 5057.241413787924, 5098.235264710286, 5074.264231686385, 5079.1365467870555, 5089.109405853961, 5089.41471730752, 5091.898162036776, 4468.419105516295, 4542.8864278392975, 4552.248878934939, 4642.46611639659, 4743.739094349844, 5137.794488220504, 5186.81846135391, 5194.065068287745, 5201.479852014844, 5202.167653175549, 4958.206686930146, 4984.601231901439, 4984.8753781155765, 4988.176950803149, 5032.018756342478, 4867.853964381075, 4924.704517728876, 4984.800607975641, 4986.027724593742, 5037.748112594356, 4987.526185012418, 4990.700557966534, 5003.549680528697, 5008.29883816266, 5055.873603159876, 4979.850604481871, 4980.626453016038, 4982.975085124551, 4983.651144419929, 5029.698218106925, 4041.818118184689, 4101.753894766323, 4144.088300573869, 4191.077962848169, 4232.0, 3615.1142969972525, 3667.1382225177063, 3671.3575124353133, 3689.8339574718666, 3712.2389910068373, 4276.508201556799, 4278.679099067583, 4280.250956082673, 4318.676099292503, 4321.632661223831, 4795.664303498722, 4921.261810728348, 4928.581070609039, 5030.320906677552, 5030.647854650139, 4231.069164783743, 4282.336237883133, 4295.82816687329, 4336.891577710519, 4338.305871060616, 4410.977945110254, 4413.801378937956, 4417.15478888815, 4454.0, 4461.219286624892, 4530.864074077783, 4629.467611224618, 4744.833930812405, 4746.5490778376, 4751.548602882721, 4895.143349913679, 4976.950230497793, 4979.601631869369, 4995.700257984533, 5029.145045342228, 4733.414834959235, 4733.5503127202865, 4741.857744267678, 4749.477557468745, 4776.95223047779, 4785.425748910153, 4897.510248975074, 4945.332380128637, 4945.431275403231, 4993.3259010034635, 4994.500549944976, 5032.370953630796, 5098.413682426569, 5123.513266239701, 5138.845834624967, 4885.682430641997, 4924.433690125681, 4925.507449255046, 4926.137925862888, 4971.850844474671, 4679.251319788954, 4795.472498025145, 4903.485134060872, 4938.851834444972, 4939.777710002986, 4726.3146843708155, 4790.5448982346625, 4857.9028419432125, 4867.123917694707, 4901.215805471107, 4894.535019173173, 4916.508349165055, 4918.532739389752, 4922.064807686528, 4955.900881982412, 4689.484156742687, 4815.711057336431, 4824.252240902666, 4825.638077144158, 4826.0], "unit": "ms", "name": "dojo.html", "value": 4595.737226857421}, {"lowerIsBetter": false, "replicates": [560.688817706173, 561.19188368749, 567.775728587208, 569.8660814708543, 571.5513322042198, 25703.871480642592, 26350.736492635067, 26355.736442635567, 35472.0, 36067.0, 38743.80628096862, 39132.0, 39216.41175382372, 39310.21379572407, 39618.80190599043, 7858.253465920757, 8041.959790201041, 8043.758687239363, 8046.517208967452, 8052.5973701315, 7183.964080179618, 7373.373263272628, 10190.64332748354, 10492.737681557946, 10494.790104197911, 9928.10647041766, 10202.38785672862, 10212.029857163594, 10214.387136771817, 10215.693529194099, 6886.0, 7015.508914375996, 10065.849012264822, 10143.949280253626, 10192.082712555868, 10211.846822297672, 10468.371897686164, 10488.58045678172, 10515.369077855277, 10531.315464494783, 37216.81391593052, 37820.43269350962, 37834.43248351277, 37868.43197352014, 37893.0526736831, 2754.559270516708, 2807.8034537582375, 2876.7698584113223, 3502.8248587570774, 3566.0, 28227.85886070577, 28303.0, 28493.57259641107, 28685.56971645427, 29093.563596545857, 3339.6159441664036, 3399.5750531183603, 3440.776349537272, 3488.3372159289906, 3540.238848647553, 214888.0, 215446.0, 215658.0, 215833.0, 216614.0, 48979.0, 52138.47861521336, 52475.0, 52485.0, 52589.2111618326, 44971.0, 61465.38534614686, 62392.00863930875, 62428.68785656043, 62675.0, 13131.474741010252, 13406.463741450429, 13455.0, 13459.865401346056, 13474.19154850712, 10025.047620476043, 10107.797844043078, 10179.0, 10204.285700000928, 10214.336068155546, 17443.21505532254, 17661.116944152996, 17767.733483997752, 17824.821751782576, 17896.731549026776, 7033.577985320897, 7162.713491460283, 7319.487635865545, 7340.669669864869, 7357.632118394166, 822.1408627983652, 839.6347588798892, 875.1423604867266, 973.6251543155794, 1012.4077414712328, 25638.063751605576, 25992.610110848353, 26268.73731262663, 26269.0, 26272.474550508883, 965.3435663748578, 967.434051080126, 1021.9540120694587, 1032.8347464405808, 1039.0804138337626, 13102.344882755824, 13221.93389033068, 13240.271785051915, 13357.666058348424, 13364.866351336557, 357542.0, 368500.0, 368638.0, 369210.0, 369541.0, 43074.0, 43421.34867976983, 43432.0, 43510.56489435065, 43619.0, 1194.1581185264367, 1207.571312184162, 1220.3471142938663, 1223.1682455929874, 1224.908131890112, 24540.631890522014, 25279.36801579975, 25882.48235035251, 25890.87054564715, 25962.35094122662, 37012.409131360546, 37400.812995934844, 37445.81277093597, 37455.06362340963, 37462.250754984205, 221891.0, 303895.0, 308296.0, 333685.0, 342203.0, 27151.72848271492, 27299.454010920068, 27308.59037114405, 27316.863415682794, 27650.92618053614, 36593.81703091467, 37100.25799483941, 37457.06357341088, 37948.430773538974, 37981.810090949366, 31518.0, 31843.36313273768, 32255.193620159684, 32643.510347344334, 32887.835560822044, 31912.07521612659, 32651.673483265815, 32701.0, 32838.83580582082, 33010.33979320352, 31807.522887157174, 32208.83895580507, 32526.674733252363, 32574.185645359055, 32683.0, 28754.712452875203, 28873.133805985854, 29588.408231834812, 30130.84934575313, 30338.393232134793, 21641.0, 22985.88507057454, 24443.633345500188, 24935.0, 25325.873370633766], "unit": "ms", "name": "ext.html", "value": 17129.495285070563}, {"lowerIsBetter": false, "replicates": [328.54988665528214, 328.5843408088767, 328.9129427242964, 334.79600225838726, 336.35587849268654, 12671.366431678402, 13069.803952940714, 14920.0, 15638.530844074681, 16171.919140404296, 8321.209485098922, 9677.0, 9762.658306959258, 9937.155341795957, 9959.751006224848, 4473.798679059434, 4631.490536041033, 4634.629229661636, 4637.536246375369, 4639.420072490939, 3262.755293352996, 3367.579052618423, 4459.0, 4517.4579050513985, 5127.051495473331, 5100.336956195708, 5141.537261646451, 5150.124478838607, 5150.1759718445055, 5151.536361727443, 5004.224345226496, 5110.310108135392, 5134.563562097226, 5140.408852981899, 5145.536901678829, 4945.67853089548, 4957.281194226817, 4958.801647934079, 4959.181735013718, 4964.05682920244, 11951.521939122425, 12848.357582120856, 17767.378141764977, 19556.80443195578, 19562.0, 1810.7464954906325, 1825.7535232743542, 1837.6692195404821, 1857.7677790276216, 1922.135039232337, 8649.827003459959, 8780.692675756382, 9023.233025192867, 9062.954685226598, 9223.031581683894, 1689.7972243330755, 1715.6054107555333, 1730.1898236996262, 1757.5166829121965, 1780.9198586063658, 53854.19218711722, 56195.43804561943, 56339.99999999959, 57650.71174644142, 57657.42342576604, 10046.296759226783, 10052.296339256181, 10072.597096116073, 10080.09279164864, 10145.137663298554, 12548.749025019632, 12708.364581770875, 12717.364131793373, 12728.172668776686, 12754.426050827735, 6911.101556797584, 6933.0, 6959.582425054412, 6969.860602787916, 7001.474889383317, 6584.176977877765, 6611.63636000015, 6612.338766123446, 6670.39966403026, 6674.733010679518, 4237.6821738369745, 4239.300515414922, 4250.341197114452, 4252.893677658021, 4305.526392096866, 1621.829707880679, 1676.1535424610493, 1700.9914950425168, 1735.5921358480748, 1743.2504023270117, 381.47547122706277, 880.423322723617, 915.1031988651159, 922.3036607361399, 954.2366107114419, 9590.42457452555, 9863.950680246697, 10014.449205293779, 10127.189824813997, 10221.488925553842, 364.9817509124533, 401.3518168158403, 402.981865816039, 411.3480133987663, 418.318141429468, 5398.973005135028, 5558.499735023867, 9109.362344635945, 9499.667511637197, 9790.902090979, 453807.0, 455544.0, 457607.0, 475799.0, 481531.0, 70528.0, 73358.0, 74830.62584687042, 75486.62256688681, 75606.0, 1032.5921261101823, 1048.2714513413105, 1050.0444595418285, 1057.8942105789513, 1081.167501024207, 14666.706665866835, 14901.0, 14914.627134321729, 15081.0, 15265.313060912064, 35389.823050885614, 35468.290634186655, 35559.82220088883, 35633.0, 35847.0, 45949.0, 46848.53151468578, 47009.52990470052, 49803.501964979885, 49887.75056124696, 8863.335249856416, 8999.820003600022, 9001.504917229353, 9097.545122743704, 9127.08729127082, 15584.454544090902, 15689.843101568838, 16149.838501614833, 16281.0, 16530.752038719187, 12984.220946743226, 13300.866991329964, 13428.798568021683, 13614.115082519604, 13826.723465530431, 12446.751064978831, 13041.413136409074, 13072.80390794158, 13325.0, 13535.458581657018, 10546.314489558154, 13461.730765384833, 13588.45646174142, 13814.171149731048, 14204.644883877985, 8355.874661879956, 8703.564821759013, 8870.51212183336, 8872.201501864864, 8890.110988901059, 12271.386430678253, 12358.258504489759, 12492.437840297027, 13506.122102063335, 13555.32223388807], "unit": "ms", "name": "jquery.html", "value": 7769.9247779628895}, {"lowerIsBetter": false, "replicates": [1422.6727852593897, 1628.7394016957285, 1667.0997661262918, 1699.3372584691965, 1710.2560386231987, 5420.1327787554, 7114.395276401506, 7253.673584688689, 7273.599952002651, 7284.854302913938, 7084.822879428017, 7223.4221262299025, 7231.096112985877, 7242.31198036187, 7270.818229544264, 1764.5588602849289, 1814.28335807356, 2077.542940553076, 2134.7331583552054, 2176.34709587124, 2134.0716788197105, 2140.6039882621685, 2144.8391370647187, 2144.849860509757, 2146.2809958663865, 2043.8058384453452, 2064.886431246281, 2080.022389476951, 2083.3541602103396, 2084.6456102462616, 1725.7583938248656, 1756.56085978506, 2075.190675636503, 2119.8622089564283, 2124.129107066111, 2112.4296439961126, 2121.5332626822074, 2144.9356519304447, 2147.044565168501, 2149.0436755643746, 7210.855782884313, 7271.854562908765, 7307.926920730778, 7308.671109800019, 7330.193678695339, 4235.047114399266, 4285.97136687196, 4304.655627549789, 4316.223079845627, 4318.892027699301, 2707.0795929383908, 2725.6320396746582, 2731.5219836528527, 2769.8615069246457, 2792.706765789583, 867.6486023160567, 902.3908861518514, 919.6689191890914, 928.0765638189977, 928.9489078100702, 9650.613975440974, 9690.806183876353, 9720.90279097207, 9738.805223895482, 9761.219102471714, 3985.960140398617, 4076.286649836267, 4111.8972025699595, 4116.217918595457, 4138.213739389506, 8361.540115293596, 8364.749057528285, 8373.246407823324, 8377.916220837713, 8393.916060839436, 4291.377750226262, 4300.053988122608, 4303.505096913895, 4306.289462238696, 4308.030693094029, 3887.3197190492115, 3909.4722212500947, 3914.784686842194, 3919.451276821247, 3921.039345360348, 3429.605595356566, 3440.552728145375, 3452.861885524551, 3480.443129099332, 3480.825958702055, 1127.7518945831903, 1145.118258940611, 1149.7987852125846, 1155.064397837754, 1161.7618388230392, 846.6063280574563, 915.3592485260344, 1141.3494308244221, 1153.2388623508443, 1163.4996951310848, 6689.899651505231, 6758.662066896733, 6777.830554236183, 6780.1524809398825, 6794.592324460449, 1042.3954106618144, 1042.5725452564411, 1079.1312993040522, 1086.2667699303097, 1087.7661302819931, 5060.949390506122, 5089.643724939218, 5095.133827249377, 5098.872528186751, 5099.209622508443, 8526.360522960802, 8552.529610871461, 8654.697085601974, 8798.824023519623, 8872.423292485968, 8602.655893764178, 8673.6530538779, 8702.303815694855, 8745.868811967826, 8797.956010219908, 6687.598744075371, 6715.0, 6752.3922846944015, 6786.524943253925, 6902.758403455855, 6434.0670602763275, 6438.29178790342, 6441.1304473895425, 6447.484201263794, 6470.741170353322, 7655.732049378245, 7786.0, 7882.0, 7940.0, 8009.078955920144, 7969.641366138421, 7974.720884769005, 8053.516788992445, 8127.878081828895, 8245.093039765741, 5792.507636850746, 5860.413958604106, 5876.0, 5877.324107727666, 5884.58807883444, 6588.967055164885, 6769.356911093439, 6769.966150169218, 6806.7957961261245, 6811.489138314745, 6356.078368636429, 6425.1968503937005, 6443.484521238383, 6513.73945042193, 6544.574602650812, 5180.352455943007, 6078.908816367846, 6360.4911607072245, 6461.0, 6537.1174891389055, 6533.607983520814, 6561.3438656134, 6580.5722628029025, 6588.40704336612, 6590.5716128451495, 5900.881982360243, 6005.699715014144, 6042.818715438544, 6044.184035155197, 6055.515558755201, 6131.110988906495, 6172.938270617236, 6179.28938172116, 6194.318624951342, 6194.969025154845], "unit": "ms", "name": "mootools.html", "value": 4136.604728859964}, {"lowerIsBetter": false, "replicates": [296.63662014032826, 302.3710681781894, 306.8757153352892, 308.34015207456036, 312.71855330202817, 5264.8157314494, 5268.341457317835, 5298.390685071218, 5299.5230429261455, 5318.122509785885, 5186.351706036746, 5210.062188806013, 5233.2150177473395, 5241.606879484045, 5255.527002569768, 3908.5505166905887, 4079.9184016319655, 4083.7549747015128, 4091.652209562191, 4093.9560412094875, 4034.1931613677234, 4041.1513582147786, 4041.333180025307, 4041.4341992121126, 4043.3732771420478, 3970.940435893464, 4092.3452247640384, 4095.9590404096025, 4097.160082183145, 4098.877033688994, 4067.247559201557, 4081.918361632751, 4086.284900142493, 4087.448194493735, 4094.0583665756894, 3417.026147547937, 3525.1010992197084, 3563.6436356364416, 3618.620044895301, 3624.72814538908, 5052.9747351263, 5060.51925067118, 5063.063333283354, 5086.4659210783075, 5097.235414687826, 4725.432948046257, 4735.715857048588, 4738.549837765407, 4741.075490279397, 4742.099001189763, 5516.779328826842, 5531.3915469298345, 5534.391216966131, 5534.754680196964, 5539.750711218005, 3848.230353929225, 3961.207758448293, 3979.383195604686, 3980.920381592352, 3984.780837053961, 5818.41815818419, 5824.155497452845, 5825.7087145642545, 5829.096490044008, 5835.416458354173, 4110.321796903538, 4113.670906327487, 4114.156597897424, 4116.115035267432, 4116.300228961084, 4167.229062623424, 4172.290710579148, 4172.645325147336, 4175.498940127204, 4176.561461046546, 4251.17102165081, 4400.295952647561, 4476.686631935799, 4713.434387873477, 4715.95284047162, 5344.839654810362, 5384.596155288369, 5408.513233808976, 5429.348478182644, 5515.338159420895, 1414.3211258595725, 1431.6349330920548, 1432.44134787433, 1432.8495507971513, 1434.4477376210025, 959.9136077753036, 960.0495509445599, 963.4508330251689, 979.0601023017982, 980.460746589373, 4836.492168322346, 4889.462159162489, 4891.853244402673, 4893.412790465167, 4893.804247830119, 5772.220750198753, 5774.0, 5777.508911742549, 5779.797707080232, 5781.4507621775865, 4831.806727730851, 4854.927176092291, 4864.854054378375, 4866.489018653061, 4870.123377791961, 2900.3329234276234, 3015.517517197238, 3081.8613162407746, 3112.797668151563, 3115.5326700995033, 4588.197065513522, 5160.303359046481, 5195.792168313225, 5422.132458806651, 5454.318210223722, 5932.762689492372, 5946.67293298864, 5947.49446297061, 5952.196453478811, 5954.255718035246, 5445.37378201504, 5459.563234941115, 5461.644993075437, 5462.453754624506, 5464.0711079116645, 5796.1305804129715, 5799.043157879071, 5801.506871915934, 5808.680522571299, 5809.360970293349, 5415.83752487426, 5619.2133101365025, 5659.405762394889, 5665.376808550974, 5678.4605462480995, 5309.920351194813, 5319.308489896289, 5333.333333333333, 5478.479544443271, 5484.8354549363585, 4023.094803669151, 4027.1140349123148, 4027.516697996259, 4035.9798201008807, 4036.656884164879, 5788.913166302593, 5801.477866991991, 5803.593748437737, 5809.5352371811, 5810.912836307374, 5443.156310771837, 5569.331680198402, 5604.607677462538, 5612.550995920398, 5624.381318054929, 5616.466435688603, 5618.831435056954, 5626.746796394254, 5631.887362252814, 5632.127020311858, 5493.807716729895, 5497.038018346853, 5513.669179849222, 5514.972425137848, 5515.889682206413, 5489.34127904638, 5629.240052592848, 5647.350554686263, 5657.4908258256955, 5660.830175094754, 5481.835544933659, 5501.642393244426, 5503.972480137573, 5508.063629183129, 5511.145772405283], "unit": "ms", "name": "prototype.html", "value": 4175.760774635163}, {"lowerIsBetter": false, "replicates": [677.9830504237392, 718.0736849464191, 738.1732459645198, 753.2730914667345, 755.199488542145, 11218.214724969255, 11461.770764584724, 11535.307881527115, 11548.191626586153, 11576.421178941051, 11149.21955463116, 11221.495032723527, 11229.933156350155, 11231.438428078603, 11247.325160490376, 614.7264467312048, 626.0171530696808, 756.29286617013, 771.4368510986969, 788.5702292250709, 779.2052106851008, 779.6998155710036, 785.0265670568483, 785.5365334452672, 785.5914924239393, 818.251300060447, 824.5135370131621, 825.2696363718122, 825.9256666899978, 827.0571548434789, 650.7559665125578, 661.193344120175, 813.3980854167933, 830.2195935820309, 830.2735106781566, 614.2690198663621, 614.5268143529502, 614.6834380294152, 614.7510258345377, 615.3477314047079, 10495.580176792919, 10622.09712174466, 10640.308379955279, 10669.35983840972, 10691.946540267249, 10961.616343427942, 11410.429478526123, 11665.766684666343, 11721.179517433782, 12141.453634586465, 8669.436486628412, 8857.247133993618, 8889.644414223423, 8965.775855603597, 9164.770880727969, 3253.6258330292085, 3279.8688052477873, 3280.2619410632656, 3283.162793487669, 3283.96716032839, 39899.40150897739, 40018.39972400387, 40290.0, 40377.0, 40623.796881015405, 8803.735887923373, 9004.684836030707, 9061.59222834974, 9162.633494660273, 9307.022762609964, 16837.831621683872, 16905.49283521496, 16936.661266774594, 16942.57643558921, 16965.406210782563, 6424.16485856845, 6465.612063276124, 6575.539712220194, 6599.373059559334, 6671.032700258435, 3377.223238655123, 3388.186835159544, 3404.4212483877304, 3404.6084700259294, 3455.127662435324, 2644.6694163229595, 2693.5959606059246, 2694.474577457377, 2700.203439985209, 2700.7434293742062, 500.1697182676739, 500.60452242728564, 506.9670471419346, 508.4534125814764, 518.5177784660302, 540.2949151357516, 557.9856717250722, 558.701094914219, 566.6345207341242, 574.810312596842, 7069.681864316118, 7202.92797072033, 7243.637818109179, 7310.671019804122, 7339.816504587428, 387.1695213766455, 396.8849033780229, 468.10124560843263, 494.2314700640467, 512.5873671694322, 3538.57537095545, 3589.5692516897616, 3709.350863598859, 3746.063484128968, 3779.5842457330223, 47532.5246747535, 49202.753986229836, 49556.75221623869, 49577.75211123921, 49957.75021124944, 41175.7941210298, 41333.379999300036, 41712.58287417087, 41867.371989420186, 41937.37093943593, 39734.0, 41282.58717412847, 41316.38025429621, 41540.75377738673, 42686.146277074906, 7601.619919004138, 7960.761177164694, 7979.122296547491, 8057.879131813144, 8113.878291825746, 31735.682643173273, 32053.35893282168, 32134.0, 32591.837040814644, 32600.0, 37211.44182837205, 38532.807335964266, 40492.0, 40544.1891162181, 40902.1819563613, 9379.249660027317, 9713.125818676353, 9851.901480985098, 9886.30795844284, 10074.949625251827, 11006.229563930448, 11080.501377438195, 11181.0, 11409.315441073562, 11629.418529073344, 9997.850032249376, 10277.486125693835, 10503.579856805642, 10523.315984460985, 11142.275752076413, 10313.22650801208, 10505.632302869362, 10546.20903432261, 10875.238733288594, 10944.781104378028, 9941.751456213653, 9991.100800927952, 10116.544755485873, 10158.238132139972, 10273.486325683536, 9256.305777066882, 9374.812503750023, 9409.576569054272, 9481.194098501428, 9564.187044101329, 8991.14584114508, 9283.72148835536, 9362.765930851783, 9448.419545230769, 9453.101955314234], "unit": "ms", "name": "yui.html", "value": 5598.3514344944315}], "name": "dromaeo_css", "value": 6242.14044669914}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 114.0, 105.0, 112.0, 112.0, 112.0, 107.0, 112.0, 114.0, 106.0], "unit": "ms", "name": "ai-astar", "value": 110.6}, {"lowerIsBetter": true, "replicates": [154.0, 127.0, 159.0, 166.0, 127.0, 165.0, 158.0, 128.0, 164.0, 128.0], "unit": "ms", "name": "audio-beat-detection", "value": 147.6}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 161.0, 160.0, 161.0, 161.0, 161.0, 162.0, 162.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 82.0, 90.0, 72.0, 72.0, 73.0, 105.0, 88.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 80.0}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 133.0, 95.0, 95.0, 94.0, 128.0, 94.0, 94.0, 126.0], "unit": "ms", "name": "audio-oscillator", "value": 105.0}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 111.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 148.0, 145.0, 147.0, 147.0, 148.0, 148.0, 148.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.0}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 70.0, 71.0, 70.0, 71.0, 72.0, 81.0, 69.0, 68.0], "unit": "ms", "name": "json-parse-financial", "value": 71.4}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 67.0, 69.0, 68.0, 68.0, 68.0, 67.0, 68.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [83.0, 86.0, 86.0, 85.0, 83.0, 82.0, 85.0, 85.0, 85.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.3}, {"lowerIsBetter": true, "replicates": [119.0, 120.0, 128.0, 127.0, 124.0, 119.0, 125.0, 122.0, 121.0, 119.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 122.4}, {"lowerIsBetter": true, "replicates": [147.0, 145.0, 144.0, 150.0, 144.0, 134.0, 148.0, 145.0, 144.0, 134.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 143.5}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 70.0, 71.0, 67.0, 67.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.3}], "name": "kraken", "value": 1514.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.31658125309968], "unit": "score", "name": "Richards", "value": 213.54179800000009}, {"lowerIsBetter": false, "replicates": [183.35166850018337], "unit": "score", "name": "DeltaBlue", "value": 360.607572}, {"lowerIsBetter": false, "replicates": [278.6291446085261], "unit": "score", "name": "Encrypt", "value": 955.3236090000001}, {"lowerIsBetter": false, "replicates": [5181.347150259067], "unit": "score", "name": "Decrypt", "value": 51.372933}, {"lowerIsBetter": false, "replicates": [1998.0039920159682], "unit": "score", "name": "RayTrace", "value": 370.36412487512496}, {"lowerIsBetter": false, "replicates": [779.423226812159], "unit": "score", "name": "Earley", "value": 855.072029}, {"lowerIsBetter": false, "replicates": [12072.289156626506], "unit": "score", "name": "Boyer", "value": 55.20601696606782}, {"lowerIsBetter": false, "replicates": [26205.128205128207], "unit": "score", "name": "RegExp", "value": 34.76361545988257}, {"lowerIsBetter": false, "replicates": [605.3268765133172], "unit": "score", "name": "Splay", "value": 134.62313200000003}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 19922.94837952032}]} 05:19:55 INFO - RETURN: dromaeo_css: 6242.14 05:19:55 INFO - RETURN: kraken: 1514.40 05:19:55 INFO - RETURN: v8_7: 19922.95 05:19:55 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,26,35]]", "result": "19922.95"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,26,35]]", "result": "1514.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,26,35]]", "result": "6242.14"}}} 05:19:55 INFO - Return code: 0 05:19:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:19:55 ERROR - # TBPL SUCCESS # 05:19:55 INFO - Running post-action listener: _resource_record_post_action 05:19:55 INFO - Running post-run listener: _resource_record_post_run 05:19:56 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 4096; Write bytes: 507555840; Read time: 8; Write time: 492892 05:19:56 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 230744064; Read time: 0; Write time: 321096 05:19:56 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 4096; Write bytes: 275980288; Read time: 8; Write time: 171756 05:19:56 INFO - Running post-run listener: _upload_blobber_files 05:19:56 INFO - Blob upload gear active. 05:19:56 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:19:56 INFO - Copying logs to upload dir... 05:19:56 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1277.267138 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-12-03 05:19:56.283976) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-03 05:19:56.287595) ========= 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=447a3abc0420b6a47dd38cba000001bf-1449146963.112510-1882458026 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/aGbSBdUXQ0OioxgcVpHllg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010046 build_url: 'https://queue.taskcluster.net/v1/task/aGbSBdUXQ0OioxgcVpHllg/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-12-03 05:19:56.340304) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 05:19:56.340687) ========= 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=447a3abc0420b6a47dd38cba000001bf-1449146963.112510-1882458026 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004459 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 05:19:56.392586) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-03 05:19:56.392949) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-03 05:19:56.393289) ========= ========= Total master_lag: 0.26 =========